builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1466253685.59 results: success (0) buildid: 20160618030212 builduid: f232ce6a95344dd2b6d98f8f02a4e347 revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.585576) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.586017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.586298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.625887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.626150) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-18 05:41:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-06-18 05:41:26 (19.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.722072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.722355) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020986 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.773145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:25.773470) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-18 05:41:26,914 truncating revision to first 12 chars 2016-06-18 05:41:26,914 Setting DEBUG logging. 2016-06-18 05:41:26,914 attempt 1/10 2016-06-18 05:41:26,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-18 05:41:27,241 unpacking tar archive at: mozilla-central-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.473732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.474001) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.474401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.474704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-18 05:41:26.492176) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-18 05:41:26.492448) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:41:27 INFO - MultiFileLogger online at 20160618 05:41:27 in /builds/slave/test 05:41:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:41:27 INFO - {'append_to_log': False, 05:41:27 INFO - 'base_work_dir': '/builds/slave/test', 05:41:27 INFO - 'blob_upload_branch': 'Firefox', 05:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:41:27 INFO - 'branch': 'Firefox', 05:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:41:27 INFO - 'config_files': ('talos/linux_config.py',), 05:41:27 INFO - 'default_actions': ('clobber', 05:41:27 INFO - 'read-buildbot-config', 05:41:27 INFO - 'download-and-extract', 05:41:27 INFO - 'populate-webroot', 05:41:27 INFO - 'create-virtualenv', 05:41:27 INFO - 'install', 05:41:27 INFO - 'run-tests'), 05:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:41:27 INFO - 'download_minidump_stackwalk': True, 05:41:27 INFO - 'download_symbols': 'ondemand', 05:41:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:41:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:41:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:41:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:41:27 INFO - 'installer_path': 'installer.exe', 05:41:27 INFO - 'log_level': 'info', 05:41:27 INFO - 'log_name': 'talos', 05:41:27 INFO - 'log_to_console': True, 05:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:41:27 INFO - 'opt_config_files': (), 05:41:27 INFO - 'pip_index': False, 05:41:27 INFO - 'sps_profile': False, 05:41:27 INFO - 'sps_profile_interval': 0, 05:41:27 INFO - 'suite': 'dromaeojs-e10s', 05:41:27 INFO - 'system_bits': '32', 05:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:41:27 INFO - 'title': 'talos-linux64-ix-017', 05:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:41:27 INFO - 'use_talos_json': True, 05:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:41:27 INFO - 'work_dir': 'build'} 05:41:27 INFO - ##### 05:41:27 INFO - ##### Running clobber step. 05:41:27 INFO - ##### 05:41:27 INFO - Running pre-action listener: _resource_record_pre_action 05:41:27 INFO - Running main action method: clobber 05:41:27 INFO - rmtree: /builds/slave/test/build 05:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:41:28 INFO - Running post-action listener: _resource_record_post_action 05:41:28 INFO - ##### 05:41:28 INFO - ##### Finished clobber step (success) 05:41:28 INFO - ##### 05:41:28 INFO - ##### 05:41:28 INFO - ##### Running read-buildbot-config step. 05:41:28 INFO - ##### 05:41:28 INFO - Running pre-action listener: _resource_record_pre_action 05:41:28 INFO - Running main action method: read_buildbot_config 05:41:28 INFO - Using buildbot properties: 05:41:28 INFO - { 05:41:28 INFO - "project": "", 05:41:28 INFO - "product": "firefox", 05:41:28 INFO - "script_repo_revision": "production", 05:41:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:41:28 INFO - "repository": "", 05:41:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:41:28 INFO - "buildid": "20160618030212", 05:41:28 INFO - "stage_platform": "linux64-pgo", 05:41:28 INFO - "basedir": "/builds/slave/test", 05:41:28 INFO - "nightly_build": "True", 05:41:28 INFO - "buildnumber": 257, 05:41:28 INFO - "slavename": "talos-linux64-ix-017", 05:41:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:41:28 INFO - "platform": "ubuntu64_hw", 05:41:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:41:28 INFO - "branch": "mozilla-central", 05:41:28 INFO - "repo_path": "mozilla-central", 05:41:28 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 05:41:28 INFO - "pgo_build": "True", 05:41:28 INFO - "builduid": "f232ce6a95344dd2b6d98f8f02a4e347", 05:41:28 INFO - "slavebuilddir": "test" 05:41:28 INFO - } 05:41:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:41:28 INFO - Running post-action listener: _resource_record_post_action 05:41:28 INFO - ##### 05:41:28 INFO - ##### Finished read-buildbot-config step (success) 05:41:28 INFO - ##### 05:41:28 INFO - ##### 05:41:28 INFO - ##### Running download-and-extract step. 05:41:28 INFO - ##### 05:41:28 INFO - Running pre-action listener: _resource_record_pre_action 05:41:28 INFO - Running main action method: download_and_extract 05:41:28 INFO - mkdir: /builds/slave/test/build/tests 05:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:28 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:41:30 INFO - Downloaded 1361 bytes. 05:41:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:41:30 INFO - Using the following test package requirements: 05:41:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:41:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:41:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'jsshell-linux-x86_64.zip'], 05:41:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:41:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:41:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:41:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:41:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:41:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:41:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:41:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:30 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:32 INFO - Downloaded 24220863 bytes. 05:41:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:41:34 INFO - Return code: 0 05:41:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:34 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:41:35 INFO - Downloaded 24220863 bytes. 05:41:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:41:36 INFO - Return code: 0 05:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:36 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:41:37 INFO - Downloaded 14405384 bytes. 05:41:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:41:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:41:37 INFO - Return code: 0 05:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:37 INFO - https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:41:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:41:40 INFO - Downloaded 60115312 bytes. 05:41:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:40 INFO - mkdir: /builds/slave/test/properties 05:41:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:41:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:41:40 INFO - Contents: 05:41:40 INFO - build_url:https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:41:41 INFO - Running post-action listener: _resource_record_post_action 05:41:41 INFO - Running post-action listener: set_extra_try_arguments 05:41:41 INFO - ##### 05:41:41 INFO - ##### Finished download-and-extract step (success) 05:41:41 INFO - ##### 05:41:41 INFO - ##### 05:41:41 INFO - ##### Running populate-webroot step. 05:41:41 INFO - ##### 05:41:41 INFO - Running pre-action listener: _resource_record_pre_action 05:41:41 INFO - Running main action method: populate_webroot 05:41:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:41:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:41:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:41:41 INFO - '--tppagecycles', 05:41:41 INFO - '7'], 05:41:41 INFO - 'tests': ['tsvgm']}}, 05:41:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:41:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:41:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:41:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:41:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:41:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['damp', 'tps']}, 05:41:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'tests': ['damp', 'tps']}, 05:41:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['dromaeo_dom']}, 05:41:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:41:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['basic_compositor_video']}, 05:41:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:41:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['a11yr', 05:41:41 INFO - 'ts_paint', 05:41:41 INFO - 'tpaint', 05:41:41 INFO - 'sessionrestore', 05:41:41 INFO - 'sessionrestore_no_auto_restore', 05:41:41 INFO - 'tabpaint']}, 05:41:41 INFO - 'other-e10s': {'tests': ['a11yr', 05:41:41 INFO - 'ts_paint', 05:41:41 INFO - 'tpaint', 05:41:41 INFO - 'sessionrestore', 05:41:41 INFO - 'sessionrestore_no_auto_restore', 05:41:41 INFO - 'tabpaint']}, 05:41:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:41:41 INFO - 'ts_paint', 05:41:41 INFO - 'tpaint', 05:41:41 INFO - 'sessionrestore', 05:41:41 INFO - 'sessionrestore_no_auto_restore', 05:41:41 INFO - 'tabpaint']}, 05:41:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:41:41 INFO - 'ts_paint', 05:41:41 INFO - 'tpaint', 05:41:41 INFO - 'sessionrestore', 05:41:41 INFO - 'sessionrestore_no_auto_restore', 05:41:41 INFO - 'tabpaint']}, 05:41:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['a11yr', 05:41:41 INFO - 'ts_paint', 05:41:41 INFO - 'tpaint', 05:41:41 INFO - 'sessionrestore', 05:41:41 INFO - 'sessionrestore_no_auto_restore', 05:41:41 INFO - 'tabpaint']}, 05:41:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['a11yr', 05:41:41 INFO - 'ts_paint', 05:41:41 INFO - 'tpaint', 05:41:41 INFO - 'sessionrestore', 05:41:41 INFO - 'sessionrestore_no_auto_restore', 05:41:41 INFO - 'tabpaint']}, 05:41:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['tsvgx', 05:41:41 INFO - 'tsvgr_opacity', 05:41:41 INFO - 'tart', 05:41:41 INFO - 'tscrollx', 05:41:41 INFO - 'cart']}, 05:41:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:41:41 INFO - 'tsvgr_opacity', 05:41:41 INFO - 'tart', 05:41:41 INFO - 'tscrollx', 05:41:41 INFO - 'cart']}, 05:41:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'talos_options': ['--disable-e10s'], 05:41:41 INFO - 'tests': ['tp5o']}, 05:41:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'tests': ['tp5o']}, 05:41:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'talos_options': ['--disable-e10s', 05:41:41 INFO - '--xperf_path', 05:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:41 INFO - 'tests': ['tp5n']}, 05:41:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:41:41 INFO - 'talos_options': ['--xperf_path', 05:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:41:41 INFO - 'tests': ['tp5n']}}, 05:41:41 INFO - 'talos.zip': {'path': '', 05:41:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:41:41 INFO - Running post-action listener: _resource_record_post_action 05:41:41 INFO - ##### 05:41:41 INFO - ##### Finished populate-webroot step (success) 05:41:41 INFO - ##### 05:41:41 INFO - ##### 05:41:41 INFO - ##### Running create-virtualenv step. 05:41:41 INFO - ##### 05:41:41 INFO - Running pre-action listener: _resource_record_pre_action 05:41:41 INFO - Running main action method: create_virtualenv 05:41:41 INFO - Creating virtualenv /builds/slave/test/build/venv 05:41:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:41:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:41:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:41:41 INFO - Using real prefix '/usr' 05:41:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:41:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:41:43 INFO - Installing pip.................done. 05:41:43 INFO - Return code: 0 05:41:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:41:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:41:43 INFO - Using env: {'DISPLAY': ':0', 05:41:43 INFO - 'HOME': '/home/cltbld', 05:41:43 INFO - 'LANG': 'en_US.UTF-8', 05:41:43 INFO - 'LANGUAGE': 'en_US:en', 05:41:43 INFO - 'LOGNAME': 'cltbld', 05:41:43 INFO - 'MAIL': '/var/mail/cltbld', 05:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:43 INFO - 'MOZ_NO_REMOTE': '1', 05:41:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:43 INFO - 'NO_EM_RESTART': '1', 05:41:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:43 INFO - 'PWD': '/builds/slave/test', 05:41:43 INFO - 'SHELL': '/bin/bash', 05:41:43 INFO - 'SHLVL': '1', 05:41:43 INFO - 'TERM': 'linux', 05:41:43 INFO - 'TMOUT': '86400', 05:41:43 INFO - 'USER': 'cltbld', 05:41:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:43 INFO - '_': '/tools/buildbot/bin/python'} 05:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:41:44 INFO - Cleaning up... 05:41:44 INFO - Return code: 0 05:41:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:41:44 INFO - Using env: {'DISPLAY': ':0', 05:41:44 INFO - 'HOME': '/home/cltbld', 05:41:44 INFO - 'LANG': 'en_US.UTF-8', 05:41:44 INFO - 'LANGUAGE': 'en_US:en', 05:41:44 INFO - 'LOGNAME': 'cltbld', 05:41:44 INFO - 'MAIL': '/var/mail/cltbld', 05:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:44 INFO - 'MOZ_NO_REMOTE': '1', 05:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:44 INFO - 'NO_EM_RESTART': '1', 05:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:44 INFO - 'PWD': '/builds/slave/test', 05:41:44 INFO - 'SHELL': '/bin/bash', 05:41:44 INFO - 'SHLVL': '1', 05:41:44 INFO - 'TERM': 'linux', 05:41:44 INFO - 'TMOUT': '86400', 05:41:44 INFO - 'USER': 'cltbld', 05:41:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:44 INFO - '_': '/tools/buildbot/bin/python'} 05:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:44 INFO - Downloading/unpacking psutil>=3.1.1 05:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:41:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:46 INFO - Installing collected packages: psutil 05:41:46 INFO - Running setup.py install for psutil 05:41:46 INFO - building 'psutil._psutil_linux' extension 05:41:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:41:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:41:46 INFO - building 'psutil._psutil_posix' extension 05:41:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:41:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:41:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:41:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:41:46 INFO - Successfully installed psutil 05:41:46 INFO - Cleaning up... 05:41:46 INFO - Return code: 0 05:41:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:41:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:41:46 INFO - Using env: {'DISPLAY': ':0', 05:41:46 INFO - 'HOME': '/home/cltbld', 05:41:46 INFO - 'LANG': 'en_US.UTF-8', 05:41:46 INFO - 'LANGUAGE': 'en_US:en', 05:41:46 INFO - 'LOGNAME': 'cltbld', 05:41:46 INFO - 'MAIL': '/var/mail/cltbld', 05:41:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:46 INFO - 'MOZ_NO_REMOTE': '1', 05:41:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:46 INFO - 'NO_EM_RESTART': '1', 05:41:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:46 INFO - 'PWD': '/builds/slave/test', 05:41:46 INFO - 'SHELL': '/bin/bash', 05:41:46 INFO - 'SHLVL': '1', 05:41:46 INFO - 'TERM': 'linux', 05:41:46 INFO - 'TMOUT': '86400', 05:41:46 INFO - 'USER': 'cltbld', 05:41:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:41:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:46 INFO - '_': '/tools/buildbot/bin/python'} 05:41:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:41:49 INFO - Installing collected packages: mozsystemmonitor 05:41:49 INFO - Running setup.py install for mozsystemmonitor 05:41:49 INFO - Successfully installed mozsystemmonitor 05:41:49 INFO - Cleaning up... 05:41:49 INFO - Return code: 0 05:41:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:41:49 INFO - Using env: {'DISPLAY': ':0', 05:41:49 INFO - 'HOME': '/home/cltbld', 05:41:49 INFO - 'LANG': 'en_US.UTF-8', 05:41:49 INFO - 'LANGUAGE': 'en_US:en', 05:41:49 INFO - 'LOGNAME': 'cltbld', 05:41:49 INFO - 'MAIL': '/var/mail/cltbld', 05:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:49 INFO - 'MOZ_NO_REMOTE': '1', 05:41:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:49 INFO - 'NO_EM_RESTART': '1', 05:41:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:49 INFO - 'PWD': '/builds/slave/test', 05:41:49 INFO - 'SHELL': '/bin/bash', 05:41:49 INFO - 'SHLVL': '1', 05:41:49 INFO - 'TERM': 'linux', 05:41:49 INFO - 'TMOUT': '86400', 05:41:49 INFO - 'USER': 'cltbld', 05:41:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:49 INFO - '_': '/tools/buildbot/bin/python'} 05:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:49 INFO - Downloading/unpacking jsonschema==2.5.1 05:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:41:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:41:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:41:51 INFO - warning: no files found matching '*.txt' 05:41:51 INFO - no previously-included directories found matching 'build' 05:41:51 INFO - no previously-included directories found matching 'dist' 05:41:51 INFO - no previously-included directories found matching '.git*' 05:41:51 INFO - Installing collected packages: jsonschema, functools32 05:41:51 INFO - Running setup.py install for functools32 05:41:51 INFO - warning: no files found matching '*.txt' 05:41:51 INFO - no previously-included directories found matching 'build' 05:41:51 INFO - no previously-included directories found matching 'dist' 05:41:51 INFO - no previously-included directories found matching '.git*' 05:41:51 INFO - Successfully installed jsonschema functools32 05:41:51 INFO - Cleaning up... 05:41:51 INFO - Return code: 0 05:41:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:41:51 INFO - Using env: {'DISPLAY': ':0', 05:41:51 INFO - 'HOME': '/home/cltbld', 05:41:51 INFO - 'LANG': 'en_US.UTF-8', 05:41:51 INFO - 'LANGUAGE': 'en_US:en', 05:41:51 INFO - 'LOGNAME': 'cltbld', 05:41:51 INFO - 'MAIL': '/var/mail/cltbld', 05:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:51 INFO - 'MOZ_NO_REMOTE': '1', 05:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:51 INFO - 'NO_EM_RESTART': '1', 05:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:51 INFO - 'PWD': '/builds/slave/test', 05:41:51 INFO - 'SHELL': '/bin/bash', 05:41:51 INFO - 'SHLVL': '1', 05:41:51 INFO - 'TERM': 'linux', 05:41:51 INFO - 'TMOUT': '86400', 05:41:51 INFO - 'USER': 'cltbld', 05:41:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:51 INFO - '_': '/tools/buildbot/bin/python'} 05:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:53 INFO - Downloading blobuploader-1.2.4.tar.gz 05:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:41:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:41:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:54 INFO - Downloading docopt-0.6.1.tar.gz 05:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:41:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:41:54 INFO - Running setup.py install for blobuploader 05:41:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:41:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:41:54 INFO - Running setup.py install for requests 05:41:55 INFO - Running setup.py install for docopt 05:41:55 INFO - Successfully installed blobuploader requests docopt 05:41:55 INFO - Cleaning up... 05:41:55 INFO - Return code: 0 05:41:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:55 INFO - Using env: {'DISPLAY': ':0', 05:41:55 INFO - 'HOME': '/home/cltbld', 05:41:55 INFO - 'LANG': 'en_US.UTF-8', 05:41:55 INFO - 'LANGUAGE': 'en_US:en', 05:41:55 INFO - 'LOGNAME': 'cltbld', 05:41:55 INFO - 'MAIL': '/var/mail/cltbld', 05:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:55 INFO - 'MOZ_NO_REMOTE': '1', 05:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:55 INFO - 'NO_EM_RESTART': '1', 05:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:55 INFO - 'PWD': '/builds/slave/test', 05:41:55 INFO - 'SHELL': '/bin/bash', 05:41:55 INFO - 'SHLVL': '1', 05:41:55 INFO - 'TERM': 'linux', 05:41:55 INFO - 'TMOUT': '86400', 05:41:55 INFO - 'USER': 'cltbld', 05:41:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:55 INFO - '_': '/tools/buildbot/bin/python'} 05:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:55 INFO - Running setup.py (path:/tmp/pip-4SrbHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:55 INFO - Running setup.py (path:/tmp/pip-ld8gcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:55 INFO - Running setup.py (path:/tmp/pip-PvvNqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:55 INFO - Running setup.py (path:/tmp/pip-WtQ9EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:55 INFO - Running setup.py (path:/tmp/pip-5jwK8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:55 INFO - Running setup.py (path:/tmp/pip-uQhb_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:55 INFO - Running setup.py (path:/tmp/pip-dAU1sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:56 INFO - Running setup.py (path:/tmp/pip-5QTc4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:56 INFO - Running setup.py (path:/tmp/pip-EmVcHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:56 INFO - Running setup.py (path:/tmp/pip-ewQwlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:56 INFO - Running setup.py (path:/tmp/pip-37nxLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:56 INFO - Running setup.py (path:/tmp/pip-WW3xVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:56 INFO - Running setup.py (path:/tmp/pip-AkUXGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:56 INFO - Running setup.py (path:/tmp/pip-rqW5E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:56 INFO - Running setup.py (path:/tmp/pip-KiiVgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:56 INFO - Running setup.py (path:/tmp/pip-dE6bTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:56 INFO - Running setup.py (path:/tmp/pip-zjOj4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:41:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:41:56 INFO - Running setup.py install for manifestparser 05:41:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:41:56 INFO - Running setup.py install for mozcrash 05:41:56 INFO - Running setup.py install for mozdebug 05:41:57 INFO - Running setup.py install for mozdevice 05:41:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozfile 05:41:57 INFO - Running setup.py install for mozhttpd 05:41:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozinfo 05:41:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozInstall 05:41:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozleak 05:41:57 INFO - Running setup.py install for mozlog 05:41:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for moznetwork 05:41:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:41:57 INFO - Running setup.py install for mozprocess 05:41:57 INFO - Running setup.py install for mozprofile 05:41:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Running setup.py install for mozrunner 05:41:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Running setup.py install for mozscreenshot 05:41:58 INFO - Running setup.py install for moztest 05:41:58 INFO - Running setup.py install for mozversion 05:41:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:41:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:41:58 INFO - Cleaning up... 05:41:58 INFO - Return code: 0 05:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:41:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:41:58 INFO - Using env: {'DISPLAY': ':0', 05:41:58 INFO - 'HOME': '/home/cltbld', 05:41:58 INFO - 'LANG': 'en_US.UTF-8', 05:41:58 INFO - 'LANGUAGE': 'en_US:en', 05:41:58 INFO - 'LOGNAME': 'cltbld', 05:41:58 INFO - 'MAIL': '/var/mail/cltbld', 05:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:58 INFO - 'MOZ_NO_REMOTE': '1', 05:41:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:58 INFO - 'NO_EM_RESTART': '1', 05:41:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:58 INFO - 'PWD': '/builds/slave/test', 05:41:58 INFO - 'SHELL': '/bin/bash', 05:41:58 INFO - 'SHLVL': '1', 05:41:58 INFO - 'TERM': 'linux', 05:41:58 INFO - 'TMOUT': '86400', 05:41:58 INFO - 'USER': 'cltbld', 05:41:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:58 INFO - '_': '/tools/buildbot/bin/python'} 05:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:41:58 INFO - Running setup.py (path:/tmp/pip-wFlXbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:41:58 INFO - Running setup.py (path:/tmp/pip-sn9DcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:41:58 INFO - Running setup.py (path:/tmp/pip-bbz0mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:41:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:41:59 INFO - Running setup.py (path:/tmp/pip-FieYDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:41:59 INFO - Running setup.py (path:/tmp/pip-c2Gurl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:41:59 INFO - Running setup.py (path:/tmp/pip-SB1mWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:41:59 INFO - Running setup.py (path:/tmp/pip-lDiycj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:41:59 INFO - Running setup.py (path:/tmp/pip-rppXn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:41:59 INFO - Running setup.py (path:/tmp/pip-1jrT87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:41:59 INFO - Running setup.py (path:/tmp/pip-tnn9a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:41:59 INFO - Running setup.py (path:/tmp/pip-FXnXZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:41:59 INFO - Running setup.py (path:/tmp/pip-8TEcQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:41:59 INFO - Running setup.py (path:/tmp/pip-v9XuBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:41:59 INFO - Running setup.py (path:/tmp/pip-caMxoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:59 INFO - Running setup.py (path:/tmp/pip-rRw6dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:41:59 INFO - Running setup.py (path:/tmp/pip-GrSP6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:41:59 INFO - Running setup.py (path:/tmp/pip-iw5uOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:42:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:01 INFO - Downloading blessings-1.6.tar.gz 05:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:42:01 INFO - Installing collected packages: blessings 05:42:01 INFO - Running setup.py install for blessings 05:42:02 INFO - Successfully installed blessings 05:42:02 INFO - Cleaning up... 05:42:02 INFO - Return code: 0 05:42:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:42:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:02 INFO - Reading from file tmpfile_stdout 05:42:02 INFO - Current package versions: 05:42:02 INFO - argparse == 1.2.1 05:42:02 INFO - blessings == 1.6 05:42:02 INFO - blobuploader == 1.2.4 05:42:02 INFO - docopt == 0.6.1 05:42:02 INFO - functools32 == 3.2.3-2 05:42:02 INFO - jsonschema == 2.5.1 05:42:02 INFO - manifestparser == 1.1 05:42:02 INFO - mozInstall == 1.12 05:42:02 INFO - mozcrash == 0.17 05:42:02 INFO - mozdebug == 0.1 05:42:02 INFO - mozdevice == 0.48 05:42:02 INFO - mozfile == 1.2 05:42:02 INFO - mozhttpd == 0.7 05:42:02 INFO - mozinfo == 0.9 05:42:02 INFO - mozleak == 0.1 05:42:02 INFO - mozlog == 3.2 05:42:02 INFO - moznetwork == 0.27 05:42:02 INFO - mozprocess == 0.22 05:42:02 INFO - mozprofile == 0.28 05:42:02 INFO - mozrunner == 6.11 05:42:02 INFO - mozscreenshot == 0.1 05:42:02 INFO - mozsystemmonitor == 0.3 05:42:02 INFO - moztest == 0.7 05:42:02 INFO - mozversion == 1.4 05:42:02 INFO - psutil == 3.1.1 05:42:02 INFO - requests == 1.2.3 05:42:02 INFO - wsgiref == 0.1.2 05:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:42:02 INFO - Using env: {'DISPLAY': ':0', 05:42:02 INFO - 'HOME': '/home/cltbld', 05:42:02 INFO - 'LANG': 'en_US.UTF-8', 05:42:02 INFO - 'LANGUAGE': 'en_US:en', 05:42:02 INFO - 'LOGNAME': 'cltbld', 05:42:02 INFO - 'MAIL': '/var/mail/cltbld', 05:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:02 INFO - 'MOZ_NO_REMOTE': '1', 05:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:02 INFO - 'NO_EM_RESTART': '1', 05:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:02 INFO - 'PWD': '/builds/slave/test', 05:42:02 INFO - 'SHELL': '/bin/bash', 05:42:02 INFO - 'SHLVL': '1', 05:42:02 INFO - 'TERM': 'linux', 05:42:02 INFO - 'TMOUT': '86400', 05:42:02 INFO - 'USER': 'cltbld', 05:42:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:02 INFO - '_': '/tools/buildbot/bin/python'} 05:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:42:02 INFO - Cleaning up... 05:42:02 INFO - Return code: 0 05:42:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:42:02 INFO - Using env: {'DISPLAY': ':0', 05:42:02 INFO - 'HOME': '/home/cltbld', 05:42:02 INFO - 'LANG': 'en_US.UTF-8', 05:42:02 INFO - 'LANGUAGE': 'en_US:en', 05:42:02 INFO - 'LOGNAME': 'cltbld', 05:42:02 INFO - 'MAIL': '/var/mail/cltbld', 05:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:02 INFO - 'MOZ_NO_REMOTE': '1', 05:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:02 INFO - 'NO_EM_RESTART': '1', 05:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:02 INFO - 'PWD': '/builds/slave/test', 05:42:02 INFO - 'SHELL': '/bin/bash', 05:42:02 INFO - 'SHLVL': '1', 05:42:02 INFO - 'TERM': 'linux', 05:42:02 INFO - 'TMOUT': '86400', 05:42:02 INFO - 'USER': 'cltbld', 05:42:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:02 INFO - '_': '/tools/buildbot/bin/python'} 05:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:42:02 INFO - Cleaning up... 05:42:02 INFO - Return code: 0 05:42:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c197af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:42:02 INFO - Using env: {'DISPLAY': ':0', 05:42:02 INFO - 'HOME': '/home/cltbld', 05:42:02 INFO - 'LANG': 'en_US.UTF-8', 05:42:02 INFO - 'LANGUAGE': 'en_US:en', 05:42:02 INFO - 'LOGNAME': 'cltbld', 05:42:02 INFO - 'MAIL': '/var/mail/cltbld', 05:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:02 INFO - 'MOZ_NO_REMOTE': '1', 05:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:02 INFO - 'NO_EM_RESTART': '1', 05:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:02 INFO - 'PWD': '/builds/slave/test', 05:42:02 INFO - 'SHELL': '/bin/bash', 05:42:02 INFO - 'SHLVL': '1', 05:42:02 INFO - 'TERM': 'linux', 05:42:02 INFO - 'TMOUT': '86400', 05:42:02 INFO - 'USER': 'cltbld', 05:42:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:02 INFO - '_': '/tools/buildbot/bin/python'} 05:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:42:03 INFO - Downloading/unpacking flake8 05:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:42:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:42:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:05 INFO - no previously-included directories found matching 'docs/_build' 05:42:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:42:05 INFO - Running setup.py install for pep8 05:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:42:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:42:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:42:05 INFO - no previously-included directories found matching 'docs/_build' 05:42:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:42:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:42:05 INFO - Cleaning up... 05:42:05 INFO - Return code: 0 05:42:05 INFO - Running post-action listener: _resource_record_post_action 05:42:05 INFO - Running post-action listener: _start_resource_monitoring 05:42:05 INFO - Starting resource monitoring. 05:42:05 INFO - ##### 05:42:05 INFO - ##### Finished create-virtualenv step (success) 05:42:05 INFO - ##### 05:42:05 INFO - ##### 05:42:05 INFO - ##### Running install step. 05:42:05 INFO - ##### 05:42:05 INFO - Running pre-action listener: _resource_record_pre_action 05:42:05 INFO - Running main action method: install 05:42:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:42:06 INFO - Reading from file tmpfile_stdout 05:42:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:42:06 INFO - Reading from file tmpfile_stdout 05:42:06 INFO - Output received: 05:42:06 INFO - Usage: mozinstall [options] installer 05:42:06 INFO - Options: 05:42:06 INFO - -h, --help show this help message and exit 05:42:06 INFO - -d DEST, --destination=DEST 05:42:06 INFO - Directory to install application into. [default: 05:42:06 INFO - "/builds/slave/test"] 05:42:06 INFO - --app=APP Application being installed. [default: firefox] 05:42:06 INFO - mkdir: /builds/slave/test/build/application 05:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:42:23 INFO - Reading from file tmpfile_stdout 05:42:23 INFO - Output received: 05:42:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:42:23 INFO - Running post-action listener: _resource_record_post_action 05:42:23 INFO - ##### 05:42:23 INFO - ##### Finished install step (success) 05:42:23 INFO - ##### 05:42:23 INFO - ##### 05:42:23 INFO - ##### Running run-tests step. 05:42:23 INFO - ##### 05:42:23 INFO - Running pre-action listener: _resource_record_pre_action 05:42:23 INFO - Running main action method: run_tests 05:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:42:23 INFO - Python 2.7.3 05:42:23 INFO - Return code: 0 05:42:23 INFO - grabbing minidump binary from tooltool 05:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:42:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:42:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:42:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:42:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:42:23 INFO - Return code: 0 05:42:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:42:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:42:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:42:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:42:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:42:24 INFO - Return code: 0 05:42:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:42:24 INFO - Using env: {'DISPLAY': ':0', 05:42:24 INFO - 'HOME': '/home/cltbld', 05:42:24 INFO - 'LANG': 'en_US.UTF-8', 05:42:24 INFO - 'LANGUAGE': 'en_US:en', 05:42:24 INFO - 'LOGNAME': 'cltbld', 05:42:24 INFO - 'MAIL': '/var/mail/cltbld', 05:42:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:42:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:42:24 INFO - 'MOZ_NO_REMOTE': '1', 05:42:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:42:24 INFO - 'NO_EM_RESTART': '1', 05:42:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:42:24 INFO - 'PWD': '/builds/slave/test', 05:42:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:42:24 INFO - 'SHELL': '/bin/bash', 05:42:24 INFO - 'SHLVL': '1', 05:42:24 INFO - 'TERM': 'linux', 05:42:24 INFO - 'TMOUT': '86400', 05:42:24 INFO - 'USER': 'cltbld', 05:42:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203', 05:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:42:24 INFO - '_': '/tools/buildbot/bin/python'} 05:42:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:42:24 INFO - mozversion application_buildid: 20160618030212 05:42:24 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 05:42:24 INFO - mozversion application_display_name: Nightly 05:42:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:42:24 INFO - mozversion application_name: Firefox 05:42:24 INFO - mozversion application_remotingname: firefox 05:42:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:42:24 INFO - mozversion application_vendor: Mozilla 05:42:24 INFO - mozversion application_version: 50.0a1 05:42:24 INFO - mozversion platform_buildid: 20160618030212 05:42:24 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 05:42:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:42:24 INFO - mozversion platform_version: 50.0a1 05:42:24 INFO - using testdate: 1466253744 05:42:24 INFO - actual date: 1466253744 05:42:24 INFO - starting webserver on 'localhost:60202' 05:42:24 INFO - SUITE-START | Running 2 tests 05:42:24 INFO - TEST-START | dromaeo_css 05:42:24 INFO - operating with platform_type : linux_ 05:42:24 INFO - Initialising browser for dromaeo_css test... 05:42:24 INFO - TEST-INFO | started process 12902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwrYMO/profile http://localhost:60202/getInfo.html) 05:42:28 INFO - PROCESS | 12902 | __metrics Screen width/height:1600/1200 05:42:28 INFO - PROCESS | 12902 | colorDepth:24 05:42:28 INFO - PROCESS | 12902 | Browser inner width/height: 1024/697 05:42:28 INFO - PROCESS | 12902 | __metrics 05:42:29 ERROR - PROCESS | 12902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:42:30 INFO - TEST-INFO | 12902: exit 0 05:42:30 INFO - Browser initialized. 05:42:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:42:30 INFO - TEST-INFO | started process 13024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwrYMO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:42 INFO - PROCESS | 13024 | RSS: Main: 184999936 05:42:42 INFO - PROCESS | 13024 | 05:43:31 INFO - PROCESS | 13024 | 1466253811879 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:45:40 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:60202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60202/tests/dromaeo/cssquery-ext.html) 05:45:41 INFO - PROCESS | 13024 | RSS: Main: 187920384 05:45:41 INFO - PROCESS | 13024 | 05:48:43 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:60202/tests/dromaeo/cssquery-ext.html (next: http://localhost:60202/tests/dromaeo/cssquery-jquery.html) 05:48:44 INFO - PROCESS | 13024 | RSS: Main: 185917440 05:48:44 INFO - PROCESS | 13024 | 05:51:45 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:60202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60202/tests/dromaeo/cssquery-mootools.html) 05:51:46 INFO - PROCESS | 13024 | RSS: Main: 188104704 05:51:46 INFO - PROCESS | 13024 | 05:54:48 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:60202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60202/tests/dromaeo/cssquery-prototype.html) 05:54:48 INFO - PROCESS | 13024 | RSS: Main: 185880576 05:54:48 INFO - PROCESS | 13024 | 05:57:51 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:60202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60202/tests/dromaeo/cssquery-yui.html) 05:57:51 INFO - PROCESS | 13024 | RSS: Main: 187715584 05:57:51 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | Cycle 1(1): loaded http://localhost:60202/tests/dromaeo/cssquery-yui.html (next: http://localhost:60202/tests/dromaeo/cssquery-dojo.html) 06:00:54 INFO - PROCESS | 13024 | RSS: Main: 189087744 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | __start_tp_report 06:00:54 INFO - PROCESS | 13024 | _x_x_mozilla_page_load 06:00:54 INFO - PROCESS | 13024 | _x_x_mozilla_page_load_details 06:00:54 INFO - PROCESS | 13024 | |i|pagename|runs| 06:00:54 INFO - PROCESS | 13024 | |0;dojo.html;3107.316390394113;3154.05378386484;3190.649028606853;3196.8881089161882;3218.2598002459436;5416.835380393215;5498.285222921025;5518.9999999999945;5541.473560011803;5575.386707462176;5468.425815289397;5533.08704063829;5544.306961629796;5562.082256427685;5565.0817615093565;4954.281629163778;5038;5106.617003724736;5179.948200518003;5192.273081768555;5047.343845300106;5175.896482070356;5227.424983251839;5240.528352448279;5242.135047717122;4944.975275123601;4953.0341583391255;4997.850064498035;5032.723200223986;5038.6724862883975;5009.824656137018;5027.2207807789855;5027.597792176617;5044.596432285409;5094.745262736848;4997.90004199914;4999.525045120708;5014.774335154927;5015.673981191211;5022.803886575459;5367.704776237305;5376.489233522809;5390.380106287748;5434.456554344573;5443.537299329561;5821.62159459638;5826.096954971986;5834.5624078194305;5843.883122337572;5846.239988801429;5785.855353616151;5839.591228613998;5885.61743486672;5886.735096920649;5933.910991335133;5508.20131080995;5508.476694713996;5521.503064724154;5586.078297080936;5598.300212473481;6063.696815159225;6064.514838812885;6071.150038994544;6089.695515224221;6096.42084002028;5662.37713851476;5807.68057756819;5842.503387212135;5845.181674565564;5854.531637468992;5874.882502349929;5917.378675239124;5934.495567876693;5949.464548190684;5993.520518358608;5699.259096317535;5876.794312199053;5927.911081333784;5943.138244954457;5957.49361304294;5696.458836410535;5949.2266005419015;6018.819435416857;6024.337322894478;6048.334683184846;4507.323901414814;4561.498235194126;4567.10941366437;4572.611328037154;4577.633789296915;4079;4084.019835239521;4096.938545921814;4112.115895082572;4120.690948178839;5437.32033495813;5512.2558454608115;5689.0328644130595;5690.658560486384;5716.114002329646;5848;5950.256217972754;5968.731407086691;5970.641761494324;6026.758929642853;5558.194061861008;5590.217369568264;5602.075657516464;5603.439656034364;5612.074007788669;5002.849914502571;5088.236764485283;5109.412417572027;5120.590352771844;5128.948710512922;6141.570090093651;6154.046122850965;6155.907661385083;6156.538259630545;6163.96918015407;5936.436038576328;5980.820575382745;5996.730147143477;6004.339522652592;6027.909581356195;5939.732712028055;6032.939670603238;6049.818505444844;6075.149479073022;6114.938850611615;5777.537796976148;5808.680522571299;5826.155207494974;5827.59206855516;5831.067029275296;5871.73577189036;5904.143899134516;5919.970400147971;5922.466977972003;5922.911156332572;5563.554915606661;5626.409227031267;5656.85857853557;5695.914561281667;5699.800506982236;5715.371309155907;5722.971385143214;5757.36668966405;5758.712064396847;5801.535877129904;5661.773529058956;5681.659100453986;5693.686847223443;5697.515711164598;5727.369989301257;5567.582431317586;5841.532677385714;5846.6784326862435;5889.94110058894;5920.934231838311;5760.94239057604;5800.854978625568;5816.302043754777;5819.476247137778;5823.621464604787 06:00:54 INFO - PROCESS | 13024 | |1;ext.html;593.8634114153745;623.6756886419063;632.3929028132992;644.2494493914588;645.3804347826086;37943;41147.17705645889;41224.58775412245;41391.379129313085;41516;42161;42757.57242427582;42790.358144627775;42846.357304640456;43099.3535096973;8661.307095432367;8792.47245165292;8878.378513504058;8885.200331970122;8895.555222238894;8689.17452841979;8755.562221888911;8770.166834150778;8772.517511536864;8792.912070879305;8773.341999350074;8795.78010549735;8802.955985220065;8812.16284452976;8863.689770858022;8752.868706969337;8769.386142969995;8778.078301778285;8785.945686517627;8812.1187881212;8501.659933602648;8600.053994060649;8604.268637165786;8622.525761083138;8631;40159.79920100381;40208.19583608341;40225.59774402277;40413.59586404128;40515.176817043306;3037.9696203037906;3323.6011678598725;3525.876594319212;3539.433690609516;3581.176329444216;30242.546361804372;30333.24166895823;30374.696253037408;31513.36973260522;32942.835285823654;4069.491313585802;4135.545090040093;4148.357004664282;4156.625903668654;4184.602462766063;322662;328071;328255;328377;329286;33271.66728332686;57489;57759.71120144372;57841.710791445774;57946;35439.11402214965;35832;35909.46135807965;35910.461343079354;35962.28075438477;15055.171965541782;15264.3894244229;15300;15328;15336.923315383352;12689.809652855214;12798.424070916832;12858.164219325714;12880.549180778815;12887.16233444823;8125.674973001132;8162.347012239006;8242;8245.093039765621;8295.377846661524;3188.139202415381;3213.196700824794;3251.626063002785;3271.9836400817844;3310.2551925816497;984.670135504614;1013.8631284776608;1040.2042437535292;1057.4818339013827;1076.5693722511057;31332.843335783633;31474.685253147632;31479.685203147674;31614.367712645617;32123;1087.586717047517;1150;1154.543955137716;1188.4057971014493;1191.3149938785234;16763.748543771853;16767.413140540022;16767.748483772753;16925.7461138083;16937.830621693625;542133;544825;545637;546528;547096;54531.273436328025;55702.442975570535;56149.15776263359;56153.43846561564;56228.71885640546;1319;1322.8346456692914;1337.25782190885;1347.5351003903638;1353.6345186799508;29795.55306670445;30061.248468788453;31025.534616980312;31118.84440577873;31559.684403156592;48405;48786;48916.266256005474;49085.754571228346;49227;445012;447191;453057;454359;454575;27122.593161102996;27575.724242757315;27651.30871728223;27828.582571261042;27836.443271134867;46482.30276545787;46911;47405.76297118492;47513.76243118762;48283.51716482931;40711.59288407078;40774.59225407708;41002.76991690254;41792.79103604584;42223.62211023049;41153.1769364617;42254;43082.353764694184;43188;43314.346760385146;39424;40098;40268.1946361077;40516.59483405246;40952;33441.49837752387;34373.656263438046;35229.29541409106;35398.64601353953;35665.82167089252;26820.329491762863;26951.865240673673;27394.178174654793;27413.17760467189;27567.448651026465 06:00:54 INFO - PROCESS | 13024 | |2;jquery.html;375.7576363245707;383.40694414706894;385.46420475538997;398.95412027616834;400.1237290334168;16714;19777.703334449958;19884.315617391647;19932.90033549834;19992.30026949055;17160.656786864256;17886.821131788678;17965.371212007583;18795.62408751824;18823.623527529442;5118.6416950813455;5308.761105750251;5320.866978325535;5328.040952628526;5563.972180139093;5689.943100569003;5711.171880077386;5727.198192253067;5738.56960727945;5750.166225897243;5562.527185189264;5638.097904335307;5671.943280567183;5690.231818704484;5707.571932105088;5656.688882111483;5671.461211184931;5701.6864072476;5711.7715291388295;5711.885762284731;4946.678465899705;5063.873403164914;5104.336436263262;5107.387113546398;5143.177091665353;12982.415791289415;13156;13445.529406470825;13465.124766890121;13692.931535342359;2238.4515793630503;2286.1312701173447;2289.107248173214;2291.576058429196;2781.4159026604234;9917.702468925943;9995.200383969264;10398.584056637725;10410.271281010333;10648.201384896087;1873.2132504348206;1894.6305470433272;1925.4993701637536;1941.1458958058408;1987.6620974434381;72184.4105519402;72850.63574682093;73482.63258683673;73803.89294160645;74632.25367746307;10498.370097794157;10535.84196237057;10898.564057437614;11002.33985960845;11220.382878941573;15144.394224230908;15184.46854360092;15197.316120774592;15210.16344101085;15218.847811521742;7902.3678105751405;8186.590670466453;8292.465893809664;8339.708110216114;8449.95775021121;7857.3321267691745;7903.56530390834;8007.279344858991;8071.354291656653;8082.151374105634;4616.976915115403;4663.836765713184;4694.201985662446;4702.7883745230865;4840.515948405202;1864.4593068010124;1945.6497830390383;1952.160570954475;1984.3550845975117;1987.3640435060931;954.6706386296717;1001.0690058245756;1010.6311196413257;1037.678319720889;1066.1790421375497;18284.54288642768;18547.25810967573;20121.698174527395;20182.19271229164;20252.291169808985;957.2485598804905;967.0474582536197;974.5906719177963;976.5361453309763;987.3582171588525;9119;9419.764505887271;11013.28413653126;11098.778024439465;11114;501587;502514;507604;512728;512810;78574;82795;92200;95430;96413.5179324113;959.7456673981401;971.3928794503577;1002.2132625888643;1006.5168719014767;1008.6873069348526;17053.317867285168;17609.911950440164;18025.09874506243;18058.187381567597;18098.185581649122;41028.384574232005;41464.3780343289;42135.15729685451;42190.367144492244;42935;58800.41199587949;59266.40733592609;59708.402915970284;60698.39301607104;61498.38501614927;7260.67326970277;8618.396712230084;8628.137186281572;8778.078301778221;8799.252063574411;11606.94196529012;12766.489340426651;12974.286414247306;13494.797578036534;13624.386902589209;11366.772664546497;11484.655460336204;11603.535858565563;11894.858925393512;11913.880861191277;11144.609938652433;11216.383098929311;11326.716832079264;11524.366159861289;11744.29534227949;11833.763324733629;11854.170208085696;11921.046316294849;12048.879511205127;12080.697982550506;7869.3311068559815;7877.291043806085;7934.841303174019;8069;8150.2664760171865;10633;11413.885861141282;11535.36555489456;11600.709982250512;11662.650120496399 06:00:54 INFO - PROCESS | 13024 | |3;mootools.html;1426.7146570685861;1448.608875603587;1532.5938626264042;1639.713050216212;1687.0974028894536;7743.496672716269;8580.742577722664;8617.741467755961;9127.26981841452;9131.817363652723;8711.30309575234;8989.14603112705;9066.50134242618;9075.81848363034;9119.954400228005;2244.9775502245016;2292.518571100071;2293.81649468043;2293.8853057347064;2294.0365046680436;2298.9540209195807;2300.66640337151;2341.1103780563362;2345.6481527770884;2352.9058837646476;2276.123692378438;2298.0577963035157;2299.37916762474;2302.3668491164894;2313.9421514462188;2229.398062523118;2232.3972527417504;2234.117523578194;2236.049678886475;2241.215574548903;2213.8450308478414;2231.3640612425543;2232.118313266267;2233.095596283508;2236.0720301075035;8908;8996.640134394616;9003.369764116514;9032.09679032098;9042.457452552868;5013.248012798073;5109.770060347293;5110.872228194287;5118.59051275897;5118.795248190068;3152.8108313501034;3187.7609179311644;3270.7546933980047;3283.622383425889;3320.3857286401853;1093.420487141808;1111.4387234446554;1113.0372228022784;1137.3801278303345;1144.1876267849836;12818.423170957329;12858.807117893239;12886.742265154644;12917.966562675058;12925.935370323183;4419.513853476115;4440.2673558862425;4578.519255478193;4592.494825569184;4618.261078227468;10593.947030264799;10607.787844243072;10612.20408469368;10615.893841061645;10644.946775266075;5240.109181439165;5319;5389.487998640123;5392.110301800238;5400.000999815047;4226.091390351089;4736.7631618418945;4922.926156107661;4932.112219800399;4983.5763960063805;3885.300645883768;3940.527136743609;4035.345508341566;4052.8378864845668;4100.097978444737;1246.401727170963;1254.6173417107686;1262.1921969939247;1264.291996481973;1270.1870802686287;907.8502047162144;912.2929729459589;923.3721069672687;925.500229875873;931.9767005824773;5666.34836993751;5670.744816483269;5673.092305231144;5710.172025056344;5892.6759028253;887.0508555845183;920.1580553793204;940.4357385568604;950.083169741203;954.6801821389912;3729.384651532521;3869.7484663496784;3877.1470276539117;3881.9611803882162;3993.4209539616595;10954.630671166104;11455.828162577567;11517.308961462339;11566.30602163873;11594.710132246593;11129.554817807359;11347.37589432589;11348.581427321586;11435.59975400857;11470.541178352772;8300.70947516834;8388.07731149573;8427.831443371098;8494.490330580185;8495.065542790288;5748.741306641127;5788.82633520995;5872.148538461985;5875.706214689163;5878.294604647299;10150.340227885164;10468.476576171313;10511.421871797125;10701.197410194422;10702.678919632424;10370.585176592851;10709.839352409565;10765.946170269099;10783;10789.568417263536;6742.831429214309;6999.4050505705545;7167.211606723361;7556.773296801105;7700.691972321044;8292.502449852787;8303.4602750821;8353.916460835313;8410.116937721452;8425.325973921948;7571.659275332733;7809.531428114331;7847;7869.0950540688555;7980.441369104339;7715;7764.184760600056;7784.610769461391;7809.843803124019;7936.56348900816;7049.400800931979;7115.679794409368;7134.643267836691;7141.428685705235;7173.390261827803;4841.370621819141;4919.901601967869;5067.49325067505;5075.492450754895;5079.390473143247;5002.699838009731;5012.373453318335;5038.067957427887;5070.03669302846;5102.846914592568 06:00:54 INFO - PROCESS | 13024 | |4;prototype.html;295.7545237452914;296.7166356129895;299.45947564645803;306.9570260163577;310.82283098633775;5700.515456186229;5719.19931209631;5749.683767392797;5749.856253593657;5766.19273301737;5566.832995010146;5575.609707320479;5601.495865372116;5604.41153678863;5607.186957891114;4073.3686278626787;4218.557051509593;4325.48094228693;4328.63206627437;4339.717918335314;4297.59172878576;4320.913581728363;4321.503027151886;4353.281708518107;4359.738415695053;4316.6186820217545;4317.352397140438;4332.591907630017;4341.891452713691;4345.935245864752;4119.485064366954;4163.895902602429;4190.580941905816;4211.473565804275;4311.016932211171;3647.0882279430143;3657.250263695936;3667.504886840269;3695.3533131702115;3718.865745947485;5471.863203419906;5487.204355368489;5505.917411238835;5506.944930550723;5508;4829.251466022772;4892.633052521075;4909.656324057318;4909.656324057318;4918.458969513351;5718.79984200551;5817.592768506206;5837.153612726131;5883.823485295448;5886.146508756249;4060.796960151981;4061.248668996245;4063.3904914262803;4068.9389659155136;4100.36444351126;5895.204147440084;6142.692865356715;6153.538484613627;6167.784127555559;6184.938150618436;4171.395147703566;4172.645325147397;4174.853880114181;4186.455760751144;4202.474690663667;4187;4209.137126888981;4238.364245363158;4245.596668316505;4259.297215959394;4837.854864354075;4899.510048995072;4913.1893237616105;4921.581665558468;4992.226204938241;5992.64044157352;5997.790077347272;6089.269287685417;6100.115483254992;6105.32841387447;1440.4670271999428;1452.259347732643;1461.861123193295;1461.978070328946;1476.438953197778;890.2566357091771;893.8915744476802;894.6868595991481;895.4671970177734;925.6760133953197;5569.412717375529;5602.831915042555;5604.271444712162;5618;5627.971860140673;6012.158297838306;6037.698115094227;6040.607360521552;6047.909281360783;6055.8486037848525;5460.890782184413;5564.777408903679;5643.109558297934;5650.237217975603;5676.744546495418;3220.178854392115;3235.142687187897;3235.822029788337;3258.5926759155104;3269.8528566214577;5929.258842644669;6164.291106522807;6165.630062196283;6197.752089916443;6210.192674952227;6145.20112385396;6149.600275982047;6196;6227.532935029801;6235.376462353819;6162.952298109242;6172.969135154385;6183.690815459299;6190.845228869314;6273;5789.56578256624;6037.18498002764;6064.848378790565;6093.146959425595;6112.266528016667;5976.9103463448955;6036.215292012011;6042.365551617193;6049.971504844099;6057.42454466825;5897.233359663216;6194.690265486617;6210.31686514474;6229.781957631461;6240.313565507699;4128.60778226068;4145.253854306254;4151.315033019518;4175.185838761412;4183.372494125905;6014.729337179925;6064.363241859718;6073.544484163794;6090.208272924669;6096.207493025879;5755.942440575708;5878.706064696663;5881.852953676022;5883.2057672213705;5893;5847.953216374405;5878.353381127987;5890.2342695449315;5908.231929849092;5916.49709774674;5350.411454739898;5791.507721843691;5818.50542703858;5831.708414579339;5853.882922341614;6002.7298771554515;6013.5189184865985;6016.909746353721;6017.458428741435;6034.366391528826;5823.7670493181495;5880.735366908414;5931;5954.910676339771;5990.910136348046 06:00:54 INFO - PROCESS | 13024 | |5;yui.html;708.7023450150933;745.9254074592545;753.261803432636;807.8263173417714;840.7141571865565;15108.848911510882;15381.69236615267;15417.691646167084;15902.84097159028;15913.840861591381;13889.30553472325;13965.231912244823;14069.788953165711;14080.718385632306;14085.92957035216;639.1052526462943;748.1321666866436;748.9288517590834;764.8279137194114;770.5723323555425;745.1021519069535;749.1908738562366;755.5957562703954;757.5492581913752;757.8181236503227;801.9318357939582;805.9959700201491;807.733447962174;808.0747544062045;808.6361137488154;798.6366203377478;802.666893239305;802.8795680647892;803.1887793328722;805.3396215103618;576.700115939709;577.4254616656453;578.2482772395869;579.1370857422453;580.0052909260638;14169.36237869288;14221.360038798175;14247.430102795875;14424.639384015378;14444.350004249834;14215.502457414044;14787.186704731235;15162.31769570372;15722.37110515578;15851.445199417965;11116.277441966327;11200.103991680646;11354.60258890943;11449.427528623619;11579.768404631945;3814.4469051987307;3885.261800257942;3893.201893611831;3907.7264591478606;3938.3895496198134;74512;74992.25007749962;75375;76442;76535.6173219136;11270;11345.546178152947;11355.148363872742;11554.653360399201;11617.593384231512;21842;21854.781452185594;21870.343889683336;21903.123875045138;21965.67051494229;8605.053444121142;8653.61058752345;8771.079036701181;8865.601047952729;8922.063183365653;4528.41130653013;4657.161710892072;4737.976310118427;4747.169245382044;4806.519348065165;3534.3991521441417;3648.4527320902075;3651.379265524814;3652.945205821915;3656.0677027358383;570.6347937320119;579.2469789273927;584.5995493087249;588.0532342927883;596.1921596237123;613.4632196827775;619.3868070610064;624.2976651267325;694.6839188169371;695.8712638161957;9977.301588888708;9977.950110249547;10037.598496060222;10045.899541004497;10282;613.3651670521078;663.7245543099559;699.8371665998501;737.4248086492545;764.5909438450402;4644.210484217691;4705.905881882343;4963.478834722302;5222.92165617516;5288.444713305124;123876;127787.1663850086;128930;132072.3396383012;132358.33820830836;107068;109971;110012.4499377498;110808.4459577697;111208;56509.99999999918;57395.71302143546;57673;91598.54200728954;94555.52722236345;10276.17790576767;10351.327163734333;10398.22013349017;10431.791364172826;10561.524731386953;35212.29575408426;35643.46534802032;47238;48135.27797082977;50525.74737126291;52625.473745262054;55601.721991389786;68089;74934;79176;12759.48962041508;13271.345730853674;13280.468781248643;13363.3986470611;13759.656008599864;14839;14891.702165956836;15183.571873055384;15206.771898421754;15463.381464741284;13567.660808479866;14263.643408914446;14326.928365358106;15164.317605707549;15176.392944282105;13714;13981;14055.437782488585;14441.566752997427;14512.927435362755;11774.116941229271;12182.269063856196;12245.10200918859;12366.381680916098;12373.814392783936;11576.479058442223;11716.882831171579;11775.823362649397;11940.402979851146;12261.877381226073;11666.650000499998;11797.334506004081;11912.52349905994;11950.34273114987;12001.39993000329 06:00:54 INFO - PROCESS | 13024 | __end_tp_report 06:00:54 INFO - PROCESS | 13024 | __start_cc_report 06:00:54 INFO - PROCESS | 13024 | _x_x_mozilla_cycle_collect,348 06:00:54 INFO - PROCESS | 13024 | __end_cc_report 06:00:54 INFO - PROCESS | 13024 | __startTimestamp1466254854574__endTimestamp 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | ------- Summary: start ------- 06:00:54 INFO - PROCESS | 13024 | Number of tests: 6 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | [#0] dojo.html Cycles:165 Average:5495.53 Median:5695.91 stddev:617.10 (10.8%) stddev-sans-first:589.87 06:00:54 INFO - PROCESS | 13024 | Values: 3107.3 3154.1 3190.6 3196.9 3218.3 5416.8 5498.3 5519.0 5541.5 5575.4 5468.4 5533.1 5544.3 5562.1 5565.1 4954.3 5038.0 5106.6 5179.9 5192.3 5047.3 5175.9 5227.4 5240.5 5242.1 4945.0 4953.0 4997.9 5032.7 5038.7 5009.8 5027.2 5027.6 5044.6 5094.7 4997.9 4999.5 5014.8 5015.7 5022.8 5367.7 5376.5 5390.4 5434.5 5443.5 5821.6 5826.1 5834.6 5843.9 5846.2 5785.9 5839.6 5885.6 5886.7 5933.9 5508.2 5508.5 5521.5 5586.1 5598.3 6063.7 6064.5 6071.2 6089.7 6096.4 5662.4 5807.7 5842.5 5845.2 5854.5 5874.9 5917.4 5934.5 5949.5 5993.5 5699.3 5876.8 5927.9 5943.1 5957.5 5696.5 5949.2 6018.8 6024.3 6048.3 4507.3 4561.5 4567.1 4572.6 4577.6 4079.0 4084.0 4096.9 4112.1 4120.7 5437.3 5512.3 5689.0 5690.7 5716.1 5848.0 5950.3 5968.7 5970.6 6026.8 5558.2 5590.2 5602.1 5603.4 5612.1 5002.8 5088.2 5109.4 5120.6 5128.9 6141.6 6154.0 6155.9 6156.5 6164.0 5936.4 5980.8 5996.7 6004.3 6027.9 5939.7 6032.9 6049.8 6075.1 6114.9 5777.5 5808.7 5826.2 5827.6 5831.1 5871.7 5904.1 5920.0 5922.5 5922.9 5563.6 5626.4 5656.9 5695.9 5699.8 5715.4 5723.0 5757.4 5758.7 5801.5 5661.8 5681.7 5693.7 5697.5 5727.4 5567.6 5841.5 5846.7 5889.9 5920.9 5760.9 5800.9 5816.3 5819.5 5823.6 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | [#1] ext.html Cycles:180 Average:58520.88 Median:22390.54 stddev:119751.29 (534.8%) stddev-sans-first:120008.24 06:00:54 INFO - PROCESS | 13024 | Values: 593.9 623.7 632.4 644.2 645.4 37943.0 41147.2 41224.6 41391.4 41516.0 42161.0 42757.6 42790.4 42846.4 43099.4 8661.3 8792.5 8878.4 8885.2 8895.6 8689.2 8755.6 8770.2 8772.5 8792.9 8773.3 8795.8 8803.0 8812.2 8863.7 8752.9 8769.4 8778.1 8785.9 8812.1 8501.7 8600.1 8604.3 8622.5 8631.0 40159.8 40208.2 40225.6 40413.6 40515.2 3038.0 3323.6 3525.9 3539.4 3581.2 30242.5 30333.2 30374.7 31513.4 32942.8 4069.5 4135.5 4148.4 4156.6 4184.6 322662.0 328071.0 328255.0 328377.0 329286.0 33271.7 57489.0 57759.7 57841.7 57946.0 35439.1 35832.0 35909.5 35910.5 35962.3 15055.2 15264.4 15300.0 15328.0 15336.9 12689.8 12798.4 12858.2 12880.5 12887.2 8125.7 8162.3 8242.0 8245.1 8295.4 3188.1 3213.2 3251.6 3272.0 3310.3 984.7 1013.9 1040.2 1057.5 1076.6 31332.8 31474.7 31479.7 31614.4 32123.0 1087.6 1150.0 1154.5 1188.4 1191.3 16763.7 16767.4 16767.7 16925.7 16937.8 542133.0 544825.0 545637.0 546528.0 547096.0 54531.3 55702.4 56149.2 56153.4 56228.7 1319.0 1322.8 1337.3 1347.5 1353.6 29795.6 30061.2 31025.5 31118.8 31559.7 48405.0 48786.0 48916.3 49085.8 49227.0 445012.0 447191.0 453057.0 454359.0 454575.0 27122.6 27575.7 27651.3 27828.6 27836.4 46482.3 46911.0 47405.8 47513.8 48283.5 40711.6 40774.6 41002.8 41792.8 42223.6 41153.2 42254.0 43082.4 43188.0 43314.3 39424.0 40098.0 40268.2 40516.6 40952.0 33441.5 34373.7 35229.3 35398.6 35665.8 26820.3 26951.9 27394.2 27413.2 27567.4 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | [#2] jquery.html Cycles:180 Average:28893.17 Median:392.21 stddev:83483.18 (21285.4%) stddev-sans-first:83689.91 06:00:54 INFO - PROCESS | 13024 | Values: 375.8 383.4 385.5 399.0 400.1 16714.0 19777.7 19884.3 19932.9 19992.3 17160.7 17886.8 17965.4 18795.6 18823.6 5118.6 5308.8 5320.9 5328.0 5564.0 5689.9 5711.2 5727.2 5738.6 5750.2 5562.5 5638.1 5671.9 5690.2 5707.6 5656.7 5671.5 5701.7 5711.8 5711.9 4946.7 5063.9 5104.3 5107.4 5143.2 12982.4 13156.0 13445.5 13465.1 13692.9 2238.5 2286.1 2289.1 2291.6 2781.4 9917.7 9995.2 10398.6 10410.3 10648.2 1873.2 1894.6 1925.5 1941.1 1987.7 72184.4 72850.6 73482.6 73803.9 74632.3 10498.4 10535.8 10898.6 11002.3 11220.4 15144.4 15184.5 15197.3 15210.2 15218.8 7902.4 8186.6 8292.5 8339.7 8450.0 7857.3 7903.6 8007.3 8071.4 8082.2 4617.0 4663.8 4694.2 4702.8 4840.5 1864.5 1945.6 1952.2 1984.4 1987.4 954.7 1001.1 1010.6 1037.7 1066.2 18284.5 18547.3 20121.7 20182.2 20252.3 957.2 967.0 974.6 976.5 987.4 9119.0 9419.8 11013.3 11098.8 11114.0 501587.0 502514.0 507604.0 512728.0 512810.0 78574.0 82795.0 92200.0 95430.0 96413.5 959.7 971.4 1002.2 1006.5 1008.7 17053.3 17609.9 18025.1 18058.2 18098.2 41028.4 41464.4 42135.2 42190.4 42935.0 58800.4 59266.4 59708.4 60698.4 61498.4 7260.7 8618.4 8628.1 8778.1 8799.3 11606.9 12766.5 12974.3 13494.8 13624.4 11366.8 11484.7 11603.5 11894.9 11913.9 11144.6 11216.4 11326.7 11524.4 11744.3 11833.8 11854.2 11921.0 12048.9 12080.7 7869.3 7877.3 7934.8 8069.0 8150.3 10633.0 11413.9 11535.4 11600.7 11662.7 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | [#3] mootools.html Cycles:180 Average:5845.26 Median:4677.51 stddev:3443.29 (73.6%) stddev-sans-first:3436.94 06:00:54 INFO - PROCESS | 13024 | Values: 1426.7 1448.6 1532.6 1639.7 1687.1 7743.5 8580.7 8617.7 9127.3 9131.8 8711.3 8989.1 9066.5 9075.8 9120.0 2245.0 2292.5 2293.8 2293.9 2294.0 2299.0 2300.7 2341.1 2345.6 2352.9 2276.1 2298.1 2299.4 2302.4 2313.9 2229.4 2232.4 2234.1 2236.0 2241.2 2213.8 2231.4 2232.1 2233.1 2236.1 8908.0 8996.6 9003.4 9032.1 9042.5 5013.2 5109.8 5110.9 5118.6 5118.8 3152.8 3187.8 3270.8 3283.6 3320.4 1093.4 1111.4 1113.0 1137.4 1144.2 12818.4 12858.8 12886.7 12918.0 12925.9 4419.5 4440.3 4578.5 4592.5 4618.3 10593.9 10607.8 10612.2 10615.9 10644.9 5240.1 5319.0 5389.5 5392.1 5400.0 4226.1 4736.8 4922.9 4932.1 4983.6 3885.3 3940.5 4035.3 4052.8 4100.1 1246.4 1254.6 1262.2 1264.3 1270.2 907.9 912.3 923.4 925.5 932.0 5666.3 5670.7 5673.1 5710.2 5892.7 887.1 920.2 940.4 950.1 954.7 3729.4 3869.7 3877.1 3882.0 3993.4 10954.6 11455.8 11517.3 11566.3 11594.7 11129.6 11347.4 11348.6 11435.6 11470.5 8300.7 8388.1 8427.8 8494.5 8495.1 5748.7 5788.8 5872.1 5875.7 5878.3 10150.3 10468.5 10511.4 10701.2 10702.7 10370.6 10709.8 10765.9 10783.0 10789.6 6742.8 6999.4 7167.2 7556.8 7700.7 8292.5 8303.5 8353.9 8410.1 8425.3 7571.7 7809.5 7847.0 7869.1 7980.4 7715.0 7764.2 7784.6 7809.8 7936.6 7049.4 7115.7 7134.6 7141.4 7173.4 4841.4 4919.9 5067.5 5075.5 5079.4 5002.7 5012.4 5038.1 5070.0 5102.8 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | [#4] prototype.html Cycles:180 Average:4927.98 Median:5688.63 stddev:1492.77 (26.2%) stddev-sans-first:1455.90 06:00:54 INFO - PROCESS | 13024 | Values: 295.8 296.7 299.5 307.0 310.8 5700.5 5719.2 5749.7 5749.9 5766.2 5566.8 5575.6 5601.5 5604.4 5607.2 4073.4 4218.6 4325.5 4328.6 4339.7 4297.6 4320.9 4321.5 4353.3 4359.7 4316.6 4317.4 4332.6 4341.9 4345.9 4119.5 4163.9 4190.6 4211.5 4311.0 3647.1 3657.3 3667.5 3695.4 3718.9 5471.9 5487.2 5505.9 5506.9 5508.0 4829.3 4892.6 4909.7 4909.7 4918.5 5718.8 5817.6 5837.2 5883.8 5886.1 4060.8 4061.2 4063.4 4068.9 4100.4 5895.2 6142.7 6153.5 6167.8 6184.9 4171.4 4172.6 4174.9 4186.5 4202.5 4187.0 4209.1 4238.4 4245.6 4259.3 4837.9 4899.5 4913.2 4921.6 4992.2 5992.6 5997.8 6089.3 6100.1 6105.3 1440.5 1452.3 1461.9 1462.0 1476.4 890.3 893.9 894.7 895.5 925.7 5569.4 5602.8 5604.3 5618.0 5628.0 6012.2 6037.7 6040.6 6047.9 6055.8 5460.9 5564.8 5643.1 5650.2 5676.7 3220.2 3235.1 3235.8 3258.6 3269.9 5929.3 6164.3 6165.6 6197.8 6210.2 6145.2 6149.6 6196.0 6227.5 6235.4 6163.0 6173.0 6183.7 6190.8 6273.0 5789.6 6037.2 6064.8 6093.1 6112.3 5976.9 6036.2 6042.4 6050.0 6057.4 5897.2 6194.7 6210.3 6229.8 6240.3 4128.6 4145.3 4151.3 4175.2 4183.4 6014.7 6064.4 6073.5 6090.2 6096.2 5755.9 5878.7 5881.9 5883.2 5893.0 5848.0 5878.4 5890.2 5908.2 5916.5 5350.4 5791.5 5818.5 5831.7 5853.9 6002.7 6013.5 6016.9 6017.5 6034.4 5823.8 5880.7 5931.0 5954.9 5990.9 06:00:54 INFO - PROCESS | 13024 | 06:00:54 INFO - PROCESS | 13024 | [#5] yui.html Cycles:180 Average:20688.25 Median:19645.96 stddev:30847.85 (157.0%) stddev-sans-first:30897.91 06:00:54 INFO - PROCESS | 13024 | Values: 708.7 745.9 753.3 807.8 840.7 15108.8 15381.7 15417.7 15902.8 15913.8 13889.3 13965.2 14069.8 14080.7 14085.9 639.1 748.1 748.9 764.8 770.6 745.1 749.2 755.6 757.5 757.8 801.9 806.0 807.7 808.1 808.6 798.6 802.7 802.9 803.2 805.3 576.7 577.4 578.2 579.1 580.0 14169.4 14221.4 14247.4 14424.6 14444.4 14215.5 14787.2 15162.3 15722.4 15851.4 11116.3 11200.1 11354.6 11449.4 11579.8 3814.4 3885.3 3893.2 3907.7 3938.4 74512.0 74992.3 75375.0 76442.0 76535.6 11270.0 11345.5 11355.1 11554.7 11617.6 21842.0 21854.8 21870.3 21903.1 21965.7 8605.1 8653.6 8771.1 8865.6 8922.1 4528.4 4657.2 4738.0 4747.2 4806.5 3534.4 3648.5 3651.4 3652.9 3656.1 570.6 579.2 584.6 588.1 596.2 613.5 619.4 624.3 694.7 695.9 9977.3 9978.0 10037.6 10045.9 10282.0 613.4 663.7 699.8 737.4 764.6 4644.2 4705.9 4963.5 5222.9 5288.4 123876.0 127787.2 128930.0 132072.3 132358.3 107068.0 109971.0 110012.4 110808.4 111208.0 56510.0 57395.7 57673.0 91598.5 94555.5 10276.2 10351.3 10398.2 10431.8 10561.5 35212.3 35643.5 47238.0 48135.3 50525.7 52625.5 55601.7 68089.0 74934.0 79176.0 12759.5 13271.3 13280.5 13363.4 13759.7 14839.0 14891.7 15183.6 15206.8 15463.4 13567.7 14263.6 14326.9 15164.3 15176.4 13714.0 13981.0 14055.4 14441.6 14512.9 11774.1 12182.3 12245.1 12366.4 12373.8 11576.5 11716.9 11775.8 11940.4 12261.9 11666.7 11797.3 11912.5 11950.3 12001.4 06:00:54 INFO - PROCESS | 13024 | -------- Summary: end -------- 06:00:54 INFO - PROCESS | 13024 | 06:00:55 INFO - TEST-INFO | 13024: exit 0 06:00:55 INFO - TEST-OK | dromaeo_css | took 1110894ms 06:00:55 INFO - TEST-START | kraken 06:00:55 INFO - operating with platform_type : linux_ 06:00:55 INFO - Initialising browser for kraken test... 06:00:55 INFO - TEST-INFO | started process 13260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6Cr5G/profile http://localhost:60202/getInfo.html) 06:00:59 INFO - PROCESS | 13260 | __metrics Screen width/height:1600/1200 06:00:59 INFO - PROCESS | 13260 | colorDepth:24 06:00:59 INFO - PROCESS | 13260 | Browser inner width/height: 1024/697 06:00:59 INFO - PROCESS | 13260 | __metrics 06:01:00 ERROR - PROCESS | 13260 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:01:00 INFO - TEST-INFO | 13260: exit 0 06:01:00 INFO - Browser initialized. 06:01:00 INFO - Running cycle 1/1 for kraken test... 06:01:00 INFO - TEST-INFO | started process 13379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6Cr5G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:12 INFO - PROCESS | 13379 | RSS: Main: 184877056 06:01:12 INFO - PROCESS | 13379 | 06:01:15 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60202/tests/kraken/driver.html?testName=audio-beat-detection) 06:01:16 INFO - PROCESS | 13379 | RSS: Main: 190697472 06:01:16 INFO - PROCESS | 13379 | 06:01:18 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60202/tests/kraken/driver.html?testName=audio-dft) 06:01:19 INFO - PROCESS | 13379 | RSS: Main: 189382656 06:01:19 INFO - PROCESS | 13379 | 06:01:22 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60202/tests/kraken/driver.html?testName=audio-fft) 06:01:23 INFO - PROCESS | 13379 | RSS: Main: 184934400 06:01:23 INFO - PROCESS | 13379 | 06:01:25 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60202/tests/kraken/driver.html?testName=audio-oscillator) 06:01:25 INFO - PROCESS | 13379 | RSS: Main: 185479168 06:01:25 INFO - PROCESS | 13379 | 06:01:28 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:01:28 INFO - PROCESS | 13379 | RSS: Main: 186142720 06:01:28 INFO - PROCESS | 13379 | 06:01:31 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60202/tests/kraken/driver.html?testName=imaging-darkroom) 06:01:32 INFO - PROCESS | 13379 | RSS: Main: 185458688 06:01:32 INFO - PROCESS | 13379 | 06:01:35 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60202/tests/kraken/driver.html?testName=imaging-desaturate) 06:01:36 INFO - PROCESS | 13379 | RSS: Main: 183189504 06:01:36 INFO - PROCESS | 13379 | 06:01:39 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60202/tests/kraken/driver.html?testName=json-parse-financial) 06:01:40 INFO - PROCESS | 13379 | RSS: Main: 184508416 06:01:40 INFO - PROCESS | 13379 | 06:01:41 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:01:42 INFO - PROCESS | 13379 | RSS: Main: 185184256 06:01:42 INFO - PROCESS | 13379 | 06:01:43 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:01:44 INFO - PROCESS | 13379 | RSS: Main: 184950784 06:01:44 INFO - PROCESS | 13379 | 06:01:46 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:01:47 INFO - PROCESS | 13379 | RSS: Main: 185675776 06:01:47 INFO - PROCESS | 13379 | 06:01:49 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:01:50 INFO - PROCESS | 13379 | RSS: Main: 187113472 06:01:50 INFO - PROCESS | 13379 | 06:01:53 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:53 INFO - PROCESS | 13379 | RSS: Main: 185974784 06:01:53 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | Cycle 1(1): loaded http://localhost:60202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60202/tests/kraken/driver.html?testName=ai-astar) 06:01:55 INFO - PROCESS | 13379 | RSS: Main: 187224064 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | __start_tp_report 06:01:55 INFO - PROCESS | 13379 | _x_x_mozilla_page_load 06:01:55 INFO - PROCESS | 13379 | _x_x_mozilla_page_load_details 06:01:55 INFO - PROCESS | 13379 | |i|pagename|runs| 06:01:55 INFO - PROCESS | 13379 | |0;ai-astar;110;108;111;110;112;109;112;110;109;109 06:01:55 INFO - PROCESS | 13379 | |1;audio-beat-detection;159;131;150;191;131;159;162;128;175;128 06:01:55 INFO - PROCESS | 13379 | |2;audio-dft;164;162;167;160;165;168;162;163;162;163 06:01:55 INFO - PROCESS | 13379 | |3;audio-fft;75;76;76;155;77;78;76;77;174;76 06:01:55 INFO - PROCESS | 13379 | |4;audio-oscillator;86;86;149;85;85;85;143;86;85;146 06:01:55 INFO - PROCESS | 13379 | |5;imaging-gaussian-blur;119;118;118;121;119;118;118;117;117;118 06:01:55 INFO - PROCESS | 13379 | |6;imaging-darkroom;147;148;147;146;149;148;148;147;147;148 06:01:55 INFO - PROCESS | 13379 | |7;imaging-desaturate;96;98;96;96;96;96;96;97;95;96 06:01:55 INFO - PROCESS | 13379 | |8;json-parse-financial;57;54;55;54;55;52;54;53;53;56 06:01:55 INFO - PROCESS | 13379 | |9;json-stringify-tinderbox;67;62;62;62;63;62;63;63;63;64 06:01:55 INFO - PROCESS | 13379 | |10;stanford-crypto-aes;84;82;81;79;83;81;80;84;107;81 06:01:55 INFO - PROCESS | 13379 | |11;stanford-crypto-ccm;128;133;134;125;127;128;130;134;126;140 06:01:55 INFO - PROCESS | 13379 | |12;stanford-crypto-pbkdf2;159;163;167;165;164;161;165;160;161;160 06:01:55 INFO - PROCESS | 13379 | |13;stanford-crypto-sha256-iterative;66;63;65;66;65;63;63;63;61;66 06:01:55 INFO - PROCESS | 13379 | __end_tp_report 06:01:55 INFO - PROCESS | 13379 | __start_cc_report 06:01:55 INFO - PROCESS | 13379 | _x_x_mozilla_cycle_collect,928 06:01:55 INFO - PROCESS | 13379 | __end_cc_report 06:01:55 INFO - PROCESS | 13379 | __startTimestamp1466254915890__endTimestamp 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | ------- Summary: start ------- 06:01:55 INFO - PROCESS | 13379 | Number of tests: 14 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:1.33 (1.2%) stddev-sans-first:1.41 06:01:55 INFO - PROCESS | 13379 | Values: 110.0 108.0 111.0 110.0 112.0 109.0 112.0 110.0 109.0 109.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:159.00 stddev:21.81 (13.7%) stddev-sans-first:22.96 06:01:55 INFO - PROCESS | 13379 | Values: 159.0 131.0 150.0 191.0 131.0 159.0 162.0 128.0 175.0 128.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.46 (1.5%) stddev-sans-first:2.60 06:01:55 INFO - PROCESS | 13379 | Values: 164.0 162.0 167.0 160.0 165.0 168.0 162.0 163.0 162.0 163.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.43 (49.3%) stddev-sans-first:39.07 06:01:55 INFO - PROCESS | 13379 | Values: 75.0 76.0 76.0 155.0 77.0 78.0 76.0 77.0 174.0 76.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:29.30 (34.5%) stddev-sans-first:30.37 06:01:55 INFO - PROCESS | 13379 | Values: 86.0 86.0 149.0 85.0 85.0 85.0 143.0 86.0 85.0 146.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.16 (1.0%) stddev-sans-first:1.20 06:01:55 INFO - PROCESS | 13379 | Values: 119.0 118.0 118.0 121.0 119.0 118.0 118.0 117.0 117.0 118.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 06:01:55 INFO - PROCESS | 13379 | Values: 147.0 148.0 147.0 146.0 149.0 148.0 148.0 147.0 147.0 148.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 06:01:55 INFO - PROCESS | 13379 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.49 (2.7%) stddev-sans-first:1.22 06:01:55 INFO - PROCESS | 13379 | Values: 57.0 54.0 55.0 54.0 55.0 52.0 54.0 53.0 53.0 56.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:0.71 06:01:55 INFO - PROCESS | 13379 | Values: 67.0 62.0 62.0 62.0 63.0 62.0 63.0 63.0 63.0 64.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.50 stddev:8.18 (10.0%) stddev-sans-first:8.67 06:01:55 INFO - PROCESS | 13379 | Values: 84.0 82.0 81.0 79.0 83.0 81.0 80.0 84.0 107.0 81.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:131.50 stddev:4.67 (3.6%) stddev-sans-first:4.87 06:01:55 INFO - PROCESS | 13379 | Values: 128.0 133.0 134.0 125.0 127.0 128.0 130.0 134.0 126.0 140.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.50 stddev:2.68 (1.6%) stddev-sans-first:2.52 06:01:55 INFO - PROCESS | 13379 | Values: 159.0 163.0 167.0 165.0 164.0 161.0 165.0 160.0 161.0 160.0 06:01:55 INFO - PROCESS | 13379 | 06:01:55 INFO - PROCESS | 13379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:65.00 stddev:1.73 (2.7%) stddev-sans-first:1.69 06:01:55 INFO - PROCESS | 13379 | Values: 66.0 63.0 65.0 66.0 65.0 63.0 63.0 63.0 61.0 66.0 06:01:55 INFO - PROCESS | 13379 | -------- Summary: end -------- 06:01:55 INFO - PROCESS | 13379 | 06:01:56 INFO - TEST-INFO | 13379: exit 0 06:01:56 INFO - TEST-OK | kraken | took 61445ms 06:01:56 INFO - SUITE-END | took 1172s 06:01:57 INFO - Completed test suite (00:19:32) 06:01:57 INFO - javascript benchmark 06:01:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7196.019109703587, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.316390394113, 3154.05378386484, 3190.649028606853, 3196.8881089161882, 3218.2598002459436, 5416.835380393215, 5498.285222921025, 5518.9999999999945, 5541.473560011803, 5575.386707462176, 5468.425815289397, 5533.08704063829, 5544.306961629796, 5562.082256427685, 5565.0817615093565, 4954.281629163778, 5038.0, 5106.617003724736, 5179.948200518003, 5192.273081768555, 5047.343845300106, 5175.896482070356, 5227.424983251839, 5240.528352448279, 5242.135047717122, 4944.975275123601, 4953.0341583391255, 4997.850064498035, 5032.723200223986, 5038.6724862883975, 5009.824656137018, 5027.2207807789855, 5027.597792176617, 5044.596432285409, 5094.745262736848, 4997.90004199914, 4999.525045120708, 5014.774335154927, 5015.673981191211, 5022.803886575459, 5367.704776237305, 5376.489233522809, 5390.380106287748, 5434.456554344573, 5443.537299329561, 5821.62159459638, 5826.096954971986, 5834.5624078194305, 5843.883122337572, 5846.239988801429, 5785.855353616151, 5839.591228613998, 5885.61743486672, 5886.735096920649, 5933.910991335133, 5508.20131080995, 5508.476694713996, 5521.503064724154, 5586.078297080936, 5598.300212473481, 6063.696815159225, 6064.514838812885, 6071.150038994544, 6089.695515224221, 6096.42084002028, 5662.37713851476, 5807.68057756819, 5842.503387212135, 5845.181674565564, 5854.531637468992, 5874.882502349929, 5917.378675239124, 5934.495567876693, 5949.464548190684, 5993.520518358608, 5699.259096317535, 5876.794312199053, 5927.911081333784, 5943.138244954457, 5957.49361304294, 5696.458836410535, 5949.2266005419015, 6018.819435416857, 6024.337322894478, 6048.334683184846, 4507.323901414814, 4561.498235194126, 4567.10941366437, 4572.611328037154, 4577.633789296915, 4079.0, 4084.019835239521, 4096.938545921814, 4112.115895082572, 4120.690948178839, 5437.32033495813, 5512.2558454608115, 5689.0328644130595, 5690.658560486384, 5716.114002329646, 5848.0, 5950.256217972754, 5968.731407086691, 5970.641761494324, 6026.758929642853, 5558.194061861008, 5590.217369568264, 5602.075657516464, 5603.439656034364, 5612.074007788669, 5002.849914502571, 5088.236764485283, 5109.412417572027, 5120.590352771844, 5128.948710512922, 6141.570090093651, 6154.046122850965, 6155.907661385083, 6156.538259630545, 6163.96918015407, 5936.436038576328, 5980.820575382745, 5996.730147143477, 6004.339522652592, 6027.909581356195, 5939.732712028055, 6032.939670603238, 6049.818505444844, 6075.149479073022, 6114.938850611615, 5777.537796976148, 5808.680522571299, 5826.155207494974, 5827.59206855516, 5831.067029275296, 5871.73577189036, 5904.143899134516, 5919.970400147971, 5922.466977972003, 5922.911156332572, 5563.554915606661, 5626.409227031267, 5656.85857853557, 5695.914561281667, 5699.800506982236, 5715.371309155907, 5722.971385143214, 5757.36668966405, 5758.712064396847, 5801.535877129904, 5661.773529058956, 5681.659100453986, 5693.686847223443, 5697.515711164598, 5727.369989301257, 5567.582431317586, 5841.532677385714, 5846.6784326862435, 5889.94110058894, 5920.934231838311, 5760.94239057604, 5800.854978625568, 5816.302043754777, 5819.476247137778, 5823.621464604787], "value": 5454.148741144981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.8634114153745, 623.6756886419063, 632.3929028132992, 644.2494493914588, 645.3804347826086, 37943.0, 41147.17705645889, 41224.58775412245, 41391.379129313085, 41516.0, 42161.0, 42757.57242427582, 42790.358144627775, 42846.357304640456, 43099.3535096973, 8661.307095432367, 8792.47245165292, 8878.378513504058, 8885.200331970122, 8895.555222238894, 8689.17452841979, 8755.562221888911, 8770.166834150778, 8772.517511536864, 8792.912070879305, 8773.341999350074, 8795.78010549735, 8802.955985220065, 8812.16284452976, 8863.689770858022, 8752.868706969337, 8769.386142969995, 8778.078301778285, 8785.945686517627, 8812.1187881212, 8501.659933602648, 8600.053994060649, 8604.268637165786, 8622.525761083138, 8631.0, 40159.79920100381, 40208.19583608341, 40225.59774402277, 40413.59586404128, 40515.176817043306, 3037.9696203037906, 3323.6011678598725, 3525.876594319212, 3539.433690609516, 3581.176329444216, 30242.546361804372, 30333.24166895823, 30374.696253037408, 31513.36973260522, 32942.835285823654, 4069.491313585802, 4135.545090040093, 4148.357004664282, 4156.625903668654, 4184.602462766063, 322662.0, 328071.0, 328255.0, 328377.0, 329286.0, 33271.66728332686, 57489.0, 57759.71120144372, 57841.710791445774, 57946.0, 35439.11402214965, 35832.0, 35909.46135807965, 35910.461343079354, 35962.28075438477, 15055.171965541782, 15264.3894244229, 15300.0, 15328.0, 15336.923315383352, 12689.809652855214, 12798.424070916832, 12858.164219325714, 12880.549180778815, 12887.16233444823, 8125.674973001132, 8162.347012239006, 8242.0, 8245.093039765621, 8295.377846661524, 3188.139202415381, 3213.196700824794, 3251.626063002785, 3271.9836400817844, 3310.2551925816497, 984.670135504614, 1013.8631284776608, 1040.2042437535292, 1057.4818339013827, 1076.5693722511057, 31332.843335783633, 31474.685253147632, 31479.685203147674, 31614.367712645617, 32123.0, 1087.586717047517, 1150.0, 1154.543955137716, 1188.4057971014493, 1191.3149938785234, 16763.748543771853, 16767.413140540022, 16767.748483772753, 16925.7461138083, 16937.830621693625, 542133.0, 544825.0, 545637.0, 546528.0, 547096.0, 54531.273436328025, 55702.442975570535, 56149.15776263359, 56153.43846561564, 56228.71885640546, 1319.0, 1322.8346456692914, 1337.25782190885, 1347.5351003903638, 1353.6345186799508, 29795.55306670445, 30061.248468788453, 31025.534616980312, 31118.84440577873, 31559.684403156592, 48405.0, 48786.0, 48916.266256005474, 49085.754571228346, 49227.0, 445012.0, 447191.0, 453057.0, 454359.0, 454575.0, 27122.593161102996, 27575.724242757315, 27651.30871728223, 27828.582571261042, 27836.443271134867, 46482.30276545787, 46911.0, 47405.76297118492, 47513.76243118762, 48283.51716482931, 40711.59288407078, 40774.59225407708, 41002.76991690254, 41792.79103604584, 42223.62211023049, 41153.1769364617, 42254.0, 43082.353764694184, 43188.0, 43314.346760385146, 39424.0, 40098.0, 40268.1946361077, 40516.59483405246, 40952.0, 33441.49837752387, 34373.656263438046, 35229.29541409106, 35398.64601353953, 35665.82167089252, 26820.329491762863, 26951.865240673673, 27394.178174654793, 27413.17760467189, 27567.448651026465], "value": 18586.67596037707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.7576363245707, 383.40694414706894, 385.46420475538997, 398.95412027616834, 400.1237290334168, 16714.0, 19777.703334449958, 19884.315617391647, 19932.90033549834, 19992.30026949055, 17160.656786864256, 17886.821131788678, 17965.371212007583, 18795.62408751824, 18823.623527529442, 5118.6416950813455, 5308.761105750251, 5320.866978325535, 5328.040952628526, 5563.972180139093, 5689.943100569003, 5711.171880077386, 5727.198192253067, 5738.56960727945, 5750.166225897243, 5562.527185189264, 5638.097904335307, 5671.943280567183, 5690.231818704484, 5707.571932105088, 5656.688882111483, 5671.461211184931, 5701.6864072476, 5711.7715291388295, 5711.885762284731, 4946.678465899705, 5063.873403164914, 5104.336436263262, 5107.387113546398, 5143.177091665353, 12982.415791289415, 13156.0, 13445.529406470825, 13465.124766890121, 13692.931535342359, 2238.4515793630503, 2286.1312701173447, 2289.107248173214, 2291.576058429196, 2781.4159026604234, 9917.702468925943, 9995.200383969264, 10398.584056637725, 10410.271281010333, 10648.201384896087, 1873.2132504348206, 1894.6305470433272, 1925.4993701637536, 1941.1458958058408, 1987.6620974434381, 72184.4105519402, 72850.63574682093, 73482.63258683673, 73803.89294160645, 74632.25367746307, 10498.370097794157, 10535.84196237057, 10898.564057437614, 11002.33985960845, 11220.382878941573, 15144.394224230908, 15184.46854360092, 15197.316120774592, 15210.16344101085, 15218.847811521742, 7902.3678105751405, 8186.590670466453, 8292.465893809664, 8339.708110216114, 8449.95775021121, 7857.3321267691745, 7903.56530390834, 8007.279344858991, 8071.354291656653, 8082.151374105634, 4616.976915115403, 4663.836765713184, 4694.201985662446, 4702.7883745230865, 4840.515948405202, 1864.4593068010124, 1945.6497830390383, 1952.160570954475, 1984.3550845975117, 1987.3640435060931, 954.6706386296717, 1001.0690058245756, 1010.6311196413257, 1037.678319720889, 1066.1790421375497, 18284.54288642768, 18547.25810967573, 20121.698174527395, 20182.19271229164, 20252.291169808985, 957.2485598804905, 967.0474582536197, 974.5906719177963, 976.5361453309763, 987.3582171588525, 9119.0, 9419.764505887271, 11013.28413653126, 11098.778024439465, 11114.0, 501587.0, 502514.0, 507604.0, 512728.0, 512810.0, 78574.0, 82795.0, 92200.0, 95430.0, 96413.5179324113, 959.7456673981401, 971.3928794503577, 1002.2132625888643, 1006.5168719014767, 1008.6873069348526, 17053.317867285168, 17609.911950440164, 18025.09874506243, 18058.187381567597, 18098.185581649122, 41028.384574232005, 41464.3780343289, 42135.15729685451, 42190.367144492244, 42935.0, 58800.41199587949, 59266.40733592609, 59708.402915970284, 60698.39301607104, 61498.38501614927, 7260.67326970277, 8618.396712230084, 8628.137186281572, 8778.078301778221, 8799.252063574411, 11606.94196529012, 12766.489340426651, 12974.286414247306, 13494.797578036534, 13624.386902589209, 11366.772664546497, 11484.655460336204, 11603.535858565563, 11894.858925393512, 11913.880861191277, 11144.609938652433, 11216.383098929311, 11326.716832079264, 11524.366159861289, 11744.29534227949, 11833.763324733629, 11854.170208085696, 11921.046316294849, 12048.879511205127, 12080.697982550506, 7869.3311068559815, 7877.291043806085, 7934.841303174019, 8069.0, 8150.2664760171865, 10633.0, 11413.885861141282, 11535.36555489456, 11600.709982250512, 11662.650120496399], "value": 8960.846802936157, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.7146570685861, 1448.608875603587, 1532.5938626264042, 1639.713050216212, 1687.0974028894536, 7743.496672716269, 8580.742577722664, 8617.741467755961, 9127.26981841452, 9131.817363652723, 8711.30309575234, 8989.14603112705, 9066.50134242618, 9075.81848363034, 9119.954400228005, 2244.9775502245016, 2292.518571100071, 2293.81649468043, 2293.8853057347064, 2294.0365046680436, 2298.9540209195807, 2300.66640337151, 2341.1103780563362, 2345.6481527770884, 2352.9058837646476, 2276.123692378438, 2298.0577963035157, 2299.37916762474, 2302.3668491164894, 2313.9421514462188, 2229.398062523118, 2232.3972527417504, 2234.117523578194, 2236.049678886475, 2241.215574548903, 2213.8450308478414, 2231.3640612425543, 2232.118313266267, 2233.095596283508, 2236.0720301075035, 8908.0, 8996.640134394616, 9003.369764116514, 9032.09679032098, 9042.457452552868, 5013.248012798073, 5109.770060347293, 5110.872228194287, 5118.59051275897, 5118.795248190068, 3152.8108313501034, 3187.7609179311644, 3270.7546933980047, 3283.622383425889, 3320.3857286401853, 1093.420487141808, 1111.4387234446554, 1113.0372228022784, 1137.3801278303345, 1144.1876267849836, 12818.423170957329, 12858.807117893239, 12886.742265154644, 12917.966562675058, 12925.935370323183, 4419.513853476115, 4440.2673558862425, 4578.519255478193, 4592.494825569184, 4618.261078227468, 10593.947030264799, 10607.787844243072, 10612.20408469368, 10615.893841061645, 10644.946775266075, 5240.109181439165, 5319.0, 5389.487998640123, 5392.110301800238, 5400.000999815047, 4226.091390351089, 4736.7631618418945, 4922.926156107661, 4932.112219800399, 4983.5763960063805, 3885.300645883768, 3940.527136743609, 4035.345508341566, 4052.8378864845668, 4100.097978444737, 1246.401727170963, 1254.6173417107686, 1262.1921969939247, 1264.291996481973, 1270.1870802686287, 907.8502047162144, 912.2929729459589, 923.3721069672687, 925.500229875873, 931.9767005824773, 5666.34836993751, 5670.744816483269, 5673.092305231144, 5710.172025056344, 5892.6759028253, 887.0508555845183, 920.1580553793204, 940.4357385568604, 950.083169741203, 954.6801821389912, 3729.384651532521, 3869.7484663496784, 3877.1470276539117, 3881.9611803882162, 3993.4209539616595, 10954.630671166104, 11455.828162577567, 11517.308961462339, 11566.30602163873, 11594.710132246593, 11129.554817807359, 11347.37589432589, 11348.581427321586, 11435.59975400857, 11470.541178352772, 8300.70947516834, 8388.07731149573, 8427.831443371098, 8494.490330580185, 8495.065542790288, 5748.741306641127, 5788.82633520995, 5872.148538461985, 5875.706214689163, 5878.294604647299, 10150.340227885164, 10468.476576171313, 10511.421871797125, 10701.197410194422, 10702.678919632424, 10370.585176592851, 10709.839352409565, 10765.946170269099, 10783.0, 10789.568417263536, 6742.831429214309, 6999.4050505705545, 7167.211606723361, 7556.773296801105, 7700.691972321044, 8292.502449852787, 8303.4602750821, 8353.916460835313, 8410.116937721452, 8425.325973921948, 7571.659275332733, 7809.531428114331, 7847.0, 7869.0950540688555, 7980.441369104339, 7715.0, 7764.184760600056, 7784.610769461391, 7809.843803124019, 7936.56348900816, 7049.400800931979, 7115.679794409368, 7134.643267836691, 7141.428685705235, 7173.390261827803, 4841.370621819141, 4919.901601967869, 5067.49325067505, 5075.492450754895, 5079.390473143247, 5002.699838009731, 5012.373453318335, 5038.067957427887, 5070.03669302846, 5102.846914592568], "value": 4623.740339564891, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.7545237452914, 296.7166356129895, 299.45947564645803, 306.9570260163577, 310.82283098633775, 5700.515456186229, 5719.19931209631, 5749.683767392797, 5749.856253593657, 5766.19273301737, 5566.832995010146, 5575.609707320479, 5601.495865372116, 5604.41153678863, 5607.186957891114, 4073.3686278626787, 4218.557051509593, 4325.48094228693, 4328.63206627437, 4339.717918335314, 4297.59172878576, 4320.913581728363, 4321.503027151886, 4353.281708518107, 4359.738415695053, 4316.6186820217545, 4317.352397140438, 4332.591907630017, 4341.891452713691, 4345.935245864752, 4119.485064366954, 4163.895902602429, 4190.580941905816, 4211.473565804275, 4311.016932211171, 3647.0882279430143, 3657.250263695936, 3667.504886840269, 3695.3533131702115, 3718.865745947485, 5471.863203419906, 5487.204355368489, 5505.917411238835, 5506.944930550723, 5508.0, 4829.251466022772, 4892.633052521075, 4909.656324057318, 4909.656324057318, 4918.458969513351, 5718.79984200551, 5817.592768506206, 5837.153612726131, 5883.823485295448, 5886.146508756249, 4060.796960151981, 4061.248668996245, 4063.3904914262803, 4068.9389659155136, 4100.36444351126, 5895.204147440084, 6142.692865356715, 6153.538484613627, 6167.784127555559, 6184.938150618436, 4171.395147703566, 4172.645325147397, 4174.853880114181, 4186.455760751144, 4202.474690663667, 4187.0, 4209.137126888981, 4238.364245363158, 4245.596668316505, 4259.297215959394, 4837.854864354075, 4899.510048995072, 4913.1893237616105, 4921.581665558468, 4992.226204938241, 5992.64044157352, 5997.790077347272, 6089.269287685417, 6100.115483254992, 6105.32841387447, 1440.4670271999428, 1452.259347732643, 1461.861123193295, 1461.978070328946, 1476.438953197778, 890.2566357091771, 893.8915744476802, 894.6868595991481, 895.4671970177734, 925.6760133953197, 5569.412717375529, 5602.831915042555, 5604.271444712162, 5618.0, 5627.971860140673, 6012.158297838306, 6037.698115094227, 6040.607360521552, 6047.909281360783, 6055.8486037848525, 5460.890782184413, 5564.777408903679, 5643.109558297934, 5650.237217975603, 5676.744546495418, 3220.178854392115, 3235.142687187897, 3235.822029788337, 3258.5926759155104, 3269.8528566214577, 5929.258842644669, 6164.291106522807, 6165.630062196283, 6197.752089916443, 6210.192674952227, 6145.20112385396, 6149.600275982047, 6196.0, 6227.532935029801, 6235.376462353819, 6162.952298109242, 6172.969135154385, 6183.690815459299, 6190.845228869314, 6273.0, 5789.56578256624, 6037.18498002764, 6064.848378790565, 6093.146959425595, 6112.266528016667, 5976.9103463448955, 6036.215292012011, 6042.365551617193, 6049.971504844099, 6057.42454466825, 5897.233359663216, 6194.690265486617, 6210.31686514474, 6229.781957631461, 6240.313565507699, 4128.60778226068, 4145.253854306254, 4151.315033019518, 4175.185838761412, 4183.372494125905, 6014.729337179925, 6064.363241859718, 6073.544484163794, 6090.208272924669, 6096.207493025879, 5755.942440575708, 5878.706064696663, 5881.852953676022, 5883.2057672213705, 5893.0, 5847.953216374405, 5878.353381127987, 5890.2342695449315, 5908.231929849092, 5916.49709774674, 5350.411454739898, 5791.507721843691, 5818.50542703858, 5831.708414579339, 5853.882922341614, 6002.7298771554515, 6013.5189184865985, 6016.909746353721, 6017.458428741435, 6034.366391528826, 5823.7670493181495, 5880.735366908414, 5931.0, 5954.910676339771, 5990.910136348046], "value": 4429.037500397138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.7023450150933, 745.9254074592545, 753.261803432636, 807.8263173417714, 840.7141571865565, 15108.848911510882, 15381.69236615267, 15417.691646167084, 15902.84097159028, 15913.840861591381, 13889.30553472325, 13965.231912244823, 14069.788953165711, 14080.718385632306, 14085.92957035216, 639.1052526462943, 748.1321666866436, 748.9288517590834, 764.8279137194114, 770.5723323555425, 745.1021519069535, 749.1908738562366, 755.5957562703954, 757.5492581913752, 757.8181236503227, 801.9318357939582, 805.9959700201491, 807.733447962174, 808.0747544062045, 808.6361137488154, 798.6366203377478, 802.666893239305, 802.8795680647892, 803.1887793328722, 805.3396215103618, 576.700115939709, 577.4254616656453, 578.2482772395869, 579.1370857422453, 580.0052909260638, 14169.36237869288, 14221.360038798175, 14247.430102795875, 14424.639384015378, 14444.350004249834, 14215.502457414044, 14787.186704731235, 15162.31769570372, 15722.37110515578, 15851.445199417965, 11116.277441966327, 11200.103991680646, 11354.60258890943, 11449.427528623619, 11579.768404631945, 3814.4469051987307, 3885.261800257942, 3893.201893611831, 3907.7264591478606, 3938.3895496198134, 74512.0, 74992.25007749962, 75375.0, 76442.0, 76535.6173219136, 11270.0, 11345.546178152947, 11355.148363872742, 11554.653360399201, 11617.593384231512, 21842.0, 21854.781452185594, 21870.343889683336, 21903.123875045138, 21965.67051494229, 8605.053444121142, 8653.61058752345, 8771.079036701181, 8865.601047952729, 8922.063183365653, 4528.41130653013, 4657.161710892072, 4737.976310118427, 4747.169245382044, 4806.519348065165, 3534.3991521441417, 3648.4527320902075, 3651.379265524814, 3652.945205821915, 3656.0677027358383, 570.6347937320119, 579.2469789273927, 584.5995493087249, 588.0532342927883, 596.1921596237123, 613.4632196827775, 619.3868070610064, 624.2976651267325, 694.6839188169371, 695.8712638161957, 9977.301588888708, 9977.950110249547, 10037.598496060222, 10045.899541004497, 10282.0, 613.3651670521078, 663.7245543099559, 699.8371665998501, 737.4248086492545, 764.5909438450402, 4644.210484217691, 4705.905881882343, 4963.478834722302, 5222.92165617516, 5288.444713305124, 123876.0, 127787.1663850086, 128930.0, 132072.3396383012, 132358.33820830836, 107068.0, 109971.0, 110012.4499377498, 110808.4459577697, 111208.0, 56509.99999999918, 57395.71302143546, 57673.0, 91598.54200728954, 94555.52722236345, 10276.17790576767, 10351.327163734333, 10398.22013349017, 10431.791364172826, 10561.524731386953, 35212.29575408426, 35643.46534802032, 47238.0, 48135.27797082977, 50525.74737126291, 52625.473745262054, 55601.721991389786, 68089.0, 74934.0, 79176.0, 12759.48962041508, 13271.345730853674, 13280.468781248643, 13363.3986470611, 13759.656008599864, 14839.0, 14891.702165956836, 15183.571873055384, 15206.771898421754, 15463.381464741284, 13567.660808479866, 14263.643408914446, 14326.928365358106, 15164.317605707549, 15176.392944282105, 13714.0, 13981.0, 14055.437782488585, 14441.566752997427, 14512.927435362755, 11774.116941229271, 12182.269063856196, 12245.10200918859, 12366.381680916098, 12373.814392783936, 11576.479058442223, 11716.882831171579, 11775.823362649397, 11940.402979851146, 12261.877381226073, 11666.650000499998, 11797.334506004081, 11912.52349905994, 11950.34273114987, 12001.39993000329], "value": 7463.349628879207, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 111.0, 110.0, 112.0, 109.0, 112.0, 110.0, 109.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 150.0, 191.0, 131.0, 159.0, 162.0, 128.0, 175.0, 128.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 167.0, 160.0, 165.0, 168.0, 162.0, 163.0, 162.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 155.0, 77.0, 78.0, 76.0, 77.0, 174.0, 76.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 149.0, 85.0, 85.0, 85.0, 143.0, 86.0, 85.0, 146.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 121.0, 119.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 149.0, 148.0, 148.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 54.0, 55.0, 52.0, 54.0, 53.0, 53.0, 56.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 79.0, 83.0, 81.0, 80.0, 84.0, 107.0, 81.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 134.0, 125.0, 127.0, 128.0, 130.0, 134.0, 126.0, 140.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 167.0, 165.0, 164.0, 161.0, 165.0, 160.0, 161.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 66.0, 65.0, 63.0, 63.0, 63.0, 61.0, 66.0], "value": 64.1, "unit": "score"}]}]} 06:01:57 INFO - Return code: 0 06:01:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:57 ERROR - # TBPL SUCCESS # 06:01:57 INFO - Running post-action listener: _resource_record_post_action 06:01:57 INFO - ##### 06:01:57 INFO - ##### Finished run-tests step (success) 06:01:57 INFO - ##### 06:01:57 INFO - Running post-run listener: _resource_record_post_run 06:01:57 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 563216384; Read time: 0; Write time: 435284 06:01:57 INFO - TinderboxPrint: CPU usage
13.4% 06:01:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:01:57 INFO - TinderboxPrint: I/O write bytes / time
563,216,384 / 435,284 06:01:57 INFO - TinderboxPrint: CPU idle
8,221.4 (86.5%) 06:01:57 INFO - TinderboxPrint: CPU user
1,223.6 (12.9%) 06:01:57 INFO - TinderboxPrint: Swap in / out
0 / 0 06:01:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 228646912; Read time: 0; Write time: 232472 06:01:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296665088; Read time: 0; Write time: 190176 06:01:57 INFO - Running post-run listener: _upload_blobber_files 06:01:57 INFO - Blob upload gear active. 06:01:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:01:58 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:01:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:01:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:59 INFO - (blobuploader) - INFO - Done attempting. 06:01:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:01:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:01:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:59 INFO - (blobuploader) - INFO - Done attempting. 06:01:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:02:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:02:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:02:04 INFO - (blobuploader) - INFO - Done attempting. 06:02:04 INFO - (blobuploader) - INFO - Iteration through files over. 06:02:04 INFO - Return code: 0 06:02:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:02:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:02:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44a834cc6d30a6e3621e556f755f1ce0d31724b5782371d76303359a59e3e6ecbae12cc8d44bf2dc256c3b5a1ab9282c26f656f6d4b2f2201cc2ee39d670a12a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dadb72e39e07db6dc65220ef7ee24873ebb50525c41a3d90d19af69534ff5154c48dfdac6f32123068da1c0b1844e6848100247a31ab9c7ab01619d05d0ed62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a0ea752feeba23523c29cb8a94331a2b57e0671ee43cd2258f929cbc2bdc3a4592b3a53958580e152d7da490f77195b452a3bbc45d2249c048e64f1b9ead1f"} 06:02:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:02:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:02:04 INFO - Contents: 06:02:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44a834cc6d30a6e3621e556f755f1ce0d31724b5782371d76303359a59e3e6ecbae12cc8d44bf2dc256c3b5a1ab9282c26f656f6d4b2f2201cc2ee39d670a12a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dadb72e39e07db6dc65220ef7ee24873ebb50525c41a3d90d19af69534ff5154c48dfdac6f32123068da1c0b1844e6848100247a31ab9c7ab01619d05d0ed62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a0ea752feeba23523c29cb8a94331a2b57e0671ee43cd2258f929cbc2bdc3a4592b3a53958580e152d7da490f77195b452a3bbc45d2249c048e64f1b9ead1f"} 06:02:04 INFO - Running post-run listener: copy_logs_to_upload_dir 06:02:04 INFO - Copying logs to upload dir... 06:02:04 INFO - mkdir: /builds/slave/test/build/upload/logs 06:02:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.838999 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-18 06:02:03.346540) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:03.349940) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44a834cc6d30a6e3621e556f755f1ce0d31724b5782371d76303359a59e3e6ecbae12cc8d44bf2dc256c3b5a1ab9282c26f656f6d4b2f2201cc2ee39d670a12a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dadb72e39e07db6dc65220ef7ee24873ebb50525c41a3d90d19af69534ff5154c48dfdac6f32123068da1c0b1844e6848100247a31ab9c7ab01619d05d0ed62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a0ea752feeba23523c29cb8a94331a2b57e0671ee43cd2258f929cbc2bdc3a4592b3a53958580e152d7da490f77195b452a3bbc45d2249c048e64f1b9ead1f"} build_url:https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/GiUJ4eEYR_uQp0cywPr0OA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44a834cc6d30a6e3621e556f755f1ce0d31724b5782371d76303359a59e3e6ecbae12cc8d44bf2dc256c3b5a1ab9282c26f656f6d4b2f2201cc2ee39d670a12a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dadb72e39e07db6dc65220ef7ee24873ebb50525c41a3d90d19af69534ff5154c48dfdac6f32123068da1c0b1844e6848100247a31ab9c7ab01619d05d0ed62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64a0ea752feeba23523c29cb8a94331a2b57e0671ee43cd2258f929cbc2bdc3a4592b3a53958580e152d7da490f77195b452a3bbc45d2249c048e64f1b9ead1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:03.375209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:03.375568) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1466251532.607799-2126592203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-18 06:02:03.460728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:02:03.461060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-18 06:02:03.461404) ========= ========= Total master_lag: 0.17 =========