builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1465852645.43 results: success (0) buildid: 20160613113007 builduid: 1a6f8dfcb8c745bc86ca222dbe777598 revision: ea5833a015a141c08d9d63b768841af97287033f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.425324) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.425746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.426320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.501384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.501669) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 14:17:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.4M=0s 2016-06-13 14:17:25 (45.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182470 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.746666) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.747196) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.048794 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.811184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:25.811578) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea5833a015a141c08d9d63b768841af97287033f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ea5833a015a141c08d9d63b768841af97287033f --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=82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 14:17:25,886 truncating revision to first 12 chars 2016-06-13 14:17:25,886 Setting DEBUG logging. 2016-06-13 14:17:25,886 attempt 1/10 2016-06-13 14:17:25,886 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea5833a015a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 14:17:26,280 unpacking tar archive at: fx-team-ea5833a015a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718901 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:26.547162) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:26.547461) ========= script_repo_revision: ea5833a015a141c08d9d63b768841af97287033f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:26.547870) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:26.548132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 14:17:26.559074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-13 14:17:26.559357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:26 INFO - MultiFileLogger online at 20160613 14:17:26 in /builds/slave/test 14:17:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:17:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:26 INFO - {'append_to_log': False, 14:17:26 INFO - 'base_work_dir': '/builds/slave/test', 14:17:26 INFO - 'blob_upload_branch': 'Fx-Team', 14:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:26 INFO - 'branch': 'Fx-Team', 14:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:26 INFO - 'config_files': ('talos/linux_config.py',), 14:17:26 INFO - 'default_actions': ('clobber', 14:17:26 INFO - 'read-buildbot-config', 14:17:26 INFO - 'download-and-extract', 14:17:26 INFO - 'populate-webroot', 14:17:26 INFO - 'create-virtualenv', 14:17:26 INFO - 'install', 14:17:26 INFO - 'run-tests'), 14:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:26 INFO - 'download_minidump_stackwalk': True, 14:17:26 INFO - 'download_symbols': 'ondemand', 14:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:26 INFO - 'installer_path': 'installer.exe', 14:17:26 INFO - 'log_level': 'info', 14:17:26 INFO - 'log_name': 'talos', 14:17:26 INFO - 'log_to_console': True, 14:17:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:26 INFO - 'opt_config_files': (), 14:17:26 INFO - 'pip_index': False, 14:17:26 INFO - 'sps_profile': False, 14:17:26 INFO - 'sps_profile_interval': 0, 14:17:26 INFO - 'suite': 'dromaeojs-e10s', 14:17:26 INFO - 'system_bits': '32', 14:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:26 INFO - 'title': 'talos-linux64-ix-066', 14:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:26 INFO - 'use_talos_json': True, 14:17:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:26 INFO - 'work_dir': 'build'} 14:17:26 INFO - ##### 14:17:26 INFO - ##### Running clobber step. 14:17:26 INFO - ##### 14:17:26 INFO - Running pre-action listener: _resource_record_pre_action 14:17:26 INFO - Running main action method: clobber 14:17:26 INFO - rmtree: /builds/slave/test/build 14:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:28 INFO - Running post-action listener: _resource_record_post_action 14:17:28 INFO - ##### 14:17:28 INFO - ##### Finished clobber step (success) 14:17:28 INFO - ##### 14:17:28 INFO - ##### 14:17:28 INFO - ##### Running read-buildbot-config step. 14:17:28 INFO - ##### 14:17:28 INFO - Running pre-action listener: _resource_record_pre_action 14:17:28 INFO - Running main action method: read_buildbot_config 14:17:28 INFO - Using buildbot properties: 14:17:28 INFO - { 14:17:28 INFO - "project": "", 14:17:28 INFO - "product": "firefox", 14:17:28 INFO - "script_repo_revision": "production", 14:17:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:17:28 INFO - "repository": "", 14:17:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:17:28 INFO - "buildid": "20160613113007", 14:17:28 INFO - "pgo_build": "True", 14:17:28 INFO - "basedir": "/builds/slave/test", 14:17:28 INFO - "buildnumber": 467, 14:17:28 INFO - "slavename": "talos-linux64-ix-066", 14:17:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:17:28 INFO - "platform": "ubuntu64_hw", 14:17:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:17:28 INFO - "branch": "fx-team", 14:17:28 INFO - "repo_path": "integration/fx-team", 14:17:28 INFO - "revision": "ea5833a015a141c08d9d63b768841af97287033f", 14:17:28 INFO - "stage_platform": "linux64-pgo", 14:17:28 INFO - "builduid": "1a6f8dfcb8c745bc86ca222dbe777598", 14:17:28 INFO - "slavebuilddir": "test" 14:17:28 INFO - } 14:17:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:17:28 INFO - Running post-action listener: _resource_record_post_action 14:17:28 INFO - ##### 14:17:28 INFO - ##### Finished read-buildbot-config step (success) 14:17:28 INFO - ##### 14:17:28 INFO - ##### 14:17:28 INFO - ##### Running download-and-extract step. 14:17:28 INFO - ##### 14:17:28 INFO - Running pre-action listener: _resource_record_pre_action 14:17:28 INFO - Running main action method: download_and_extract 14:17:28 INFO - mkdir: /builds/slave/test/build/tests 14:17: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')]} 14:17:28 INFO - https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:41 INFO - Downloaded 1361 bytes. 14:17:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:41 INFO - Using the following test package requirements: 14:17:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:17:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:17:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'jsshell-linux-x86_64.zip'], 14:17:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:17:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:17:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:17:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:17:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:17:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:17:41 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')]} 14:17:41 INFO - https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:45 INFO - Downloaded 24217958 bytes. 14:17:45 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'] 14:17:45 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 14:17:47 INFO - Return code: 0 14:17:47 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 14:17:47 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')]} 14:17:47 INFO - https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:49 INFO - Downloaded 24217958 bytes. 14:17:49 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'] 14:17:49 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 14:17:51 INFO - Return code: 0 14:17: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')]} 14:17:51 INFO - https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:17:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:52 INFO - Downloaded 14405384 bytes. 14:17:52 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'] 14:17:52 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 14:17:52 INFO - Return code: 0 14:17:52 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')]} 14:17:52 INFO - https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:17:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e7bM722-SJaoh08Ou2bS-Q/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 14:17:54 INFO - Downloaded 59322252 bytes. 14:17:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:54 INFO - mkdir: /builds/slave/test/properties 14:17:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:54 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:54 INFO - Contents: 14:17:54 INFO - build_url:https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:54 INFO - Running post-action listener: _resource_record_post_action 14:17:54 INFO - Running post-action listener: set_extra_try_arguments 14:17:54 INFO - ##### 14:17:54 INFO - ##### Finished download-and-extract step (success) 14:17:54 INFO - ##### 14:17:54 INFO - ##### 14:17:54 INFO - ##### Running populate-webroot step. 14:17:54 INFO - ##### 14:17:54 INFO - Running pre-action listener: _resource_record_pre_action 14:17:54 INFO - Running main action method: populate_webroot 14:17:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:54 INFO - '--tppagecycles', 14:17:54 INFO - '7'], 14:17:54 INFO - 'tests': ['tsvgm']}}, 14:17:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:17:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:17:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['damp', 'tps']}, 14:17:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'tests': ['damp', 'tps']}, 14:17:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['dromaeo_dom']}, 14:17:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['basic_compositor_video']}, 14:17:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:17:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['a11yr', 14:17:54 INFO - 'ts_paint', 14:17:54 INFO - 'tpaint', 14:17:54 INFO - 'sessionrestore', 14:17:54 INFO - 'sessionrestore_no_auto_restore', 14:17:54 INFO - 'tabpaint']}, 14:17:54 INFO - 'other-e10s': {'tests': ['a11yr', 14:17:54 INFO - 'ts_paint', 14:17:54 INFO - 'tpaint', 14:17:54 INFO - 'sessionrestore', 14:17:54 INFO - 'sessionrestore_no_auto_restore', 14:17:54 INFO - 'tabpaint']}, 14:17:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:17:54 INFO - 'ts_paint', 14:17:54 INFO - 'tpaint', 14:17:54 INFO - 'sessionrestore', 14:17:54 INFO - 'sessionrestore_no_auto_restore', 14:17:54 INFO - 'tabpaint']}, 14:17:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:17:54 INFO - 'ts_paint', 14:17:54 INFO - 'tpaint', 14:17:54 INFO - 'sessionrestore', 14:17:54 INFO - 'sessionrestore_no_auto_restore', 14:17:54 INFO - 'tabpaint']}, 14:17:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['a11yr', 14:17:54 INFO - 'ts_paint', 14:17:54 INFO - 'tpaint', 14:17:54 INFO - 'sessionrestore', 14:17:54 INFO - 'sessionrestore_no_auto_restore', 14:17:54 INFO - 'tabpaint']}, 14:17:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['a11yr', 14:17:54 INFO - 'ts_paint', 14:17:54 INFO - 'tpaint', 14:17:54 INFO - 'sessionrestore', 14:17:54 INFO - 'sessionrestore_no_auto_restore', 14:17:54 INFO - 'tabpaint']}, 14:17:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['tsvgx', 14:17:54 INFO - 'tsvgr_opacity', 14:17:54 INFO - 'tart', 14:17:54 INFO - 'tscrollx', 14:17:54 INFO - 'cart']}, 14:17:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:17:54 INFO - 'tsvgr_opacity', 14:17:54 INFO - 'tart', 14:17:54 INFO - 'tscrollx', 14:17:54 INFO - 'cart']}, 14:17:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'talos_options': ['--disable-e10s'], 14:17:54 INFO - 'tests': ['tp5o']}, 14:17:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'tests': ['tp5o']}, 14:17:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'talos_options': ['--disable-e10s', 14:17:54 INFO - '--xperf_path', 14:17:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:54 INFO - 'tests': ['tp5n']}, 14:17:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:54 INFO - 'talos_options': ['--xperf_path', 14:17:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:54 INFO - 'tests': ['tp5n']}}, 14:17:54 INFO - 'talos.zip': {'path': '', 14:17:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:54 INFO - Running post-action listener: _resource_record_post_action 14:17:54 INFO - ##### 14:17:54 INFO - ##### Finished populate-webroot step (success) 14:17:54 INFO - ##### 14:17:54 INFO - ##### 14:17:54 INFO - ##### Running create-virtualenv step. 14:17:54 INFO - ##### 14:17:54 INFO - Running pre-action listener: _resource_record_pre_action 14:17:54 INFO - Running main action method: create_virtualenv 14:17:54 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:54 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 14:17:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:55 INFO - Using real prefix '/usr' 14:17:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:57 INFO - Installing pip.................done. 14:17:57 INFO - Return code: 0 14:17:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17:57 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')]} 14:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:57 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')]} 14:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:57 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:17:57 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 14:17:57 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 14:17:57 INFO - Using env: {'DISPLAY': ':0', 14:17:57 INFO - 'HOME': '/home/cltbld', 14:17:57 INFO - 'LANG': 'en_US.UTF-8', 14:17:57 INFO - 'LANGUAGE': 'en_US:en', 14:17:57 INFO - 'LOGNAME': 'cltbld', 14:17:57 INFO - 'MAIL': '/var/mail/cltbld', 14:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:57 INFO - 'MOZ_NO_REMOTE': '1', 14:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:57 INFO - 'NO_EM_RESTART': '1', 14:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:57 INFO - 'PWD': '/builds/slave/test', 14:17:57 INFO - 'SHELL': '/bin/bash', 14:17:57 INFO - 'SHLVL': '1', 14:17:57 INFO - 'TERM': 'linux', 14:17:57 INFO - 'TMOUT': '86400', 14:17:57 INFO - 'USER': 'cltbld', 14:17:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:57 INFO - '_': '/tools/buildbot/bin/python'} 14:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:57 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 14:17:57 INFO - Cleaning up... 14:17:57 INFO - Return code: 0 14:17:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:17:57 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')]} 14:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:57 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')]} 14:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:57 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:17:57 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 14:17:57 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 14:17:57 INFO - Using env: {'DISPLAY': ':0', 14:17:57 INFO - 'HOME': '/home/cltbld', 14:17:57 INFO - 'LANG': 'en_US.UTF-8', 14:17:57 INFO - 'LANGUAGE': 'en_US:en', 14:17:57 INFO - 'LOGNAME': 'cltbld', 14:17:57 INFO - 'MAIL': '/var/mail/cltbld', 14:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:57 INFO - 'MOZ_NO_REMOTE': '1', 14:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:57 INFO - 'NO_EM_RESTART': '1', 14:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:57 INFO - 'PWD': '/builds/slave/test', 14:17:57 INFO - 'SHELL': '/bin/bash', 14:17:57 INFO - 'SHLVL': '1', 14:17:57 INFO - 'TERM': 'linux', 14:17:57 INFO - 'TMOUT': '86400', 14:17:57 INFO - 'USER': 'cltbld', 14:17:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:57 INFO - '_': '/tools/buildbot/bin/python'} 14:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:58 INFO - Downloading/unpacking psutil>=3.1.1 14:17:58 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 14:17:58 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 14:17:58 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 14:17:58 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 14:17:58 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 14:17:58 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 14:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:00 INFO - Installing collected packages: psutil 14:18:00 INFO - Running setup.py install for psutil 14:18:00 INFO - building 'psutil._psutil_linux' extension 14:18:00 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 14:18:01 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 14:18:01 INFO - building 'psutil._psutil_posix' extension 14:18:01 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 14:18:01 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 14:18:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:01 INFO - Successfully installed psutil 14:18:01 INFO - Cleaning up... 14:18:01 INFO - Return code: 0 14:18:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:18:01 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')]} 14:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:01 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')]} 14:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:01 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:01 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 14:18:01 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 14:18:01 INFO - Using env: {'DISPLAY': ':0', 14:18:01 INFO - 'HOME': '/home/cltbld', 14:18:01 INFO - 'LANG': 'en_US.UTF-8', 14:18:01 INFO - 'LANGUAGE': 'en_US:en', 14:18:01 INFO - 'LOGNAME': 'cltbld', 14:18:01 INFO - 'MAIL': '/var/mail/cltbld', 14:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:01 INFO - 'MOZ_NO_REMOTE': '1', 14:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:01 INFO - 'NO_EM_RESTART': '1', 14:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:01 INFO - 'PWD': '/builds/slave/test', 14:18:01 INFO - 'SHELL': '/bin/bash', 14:18:01 INFO - 'SHLVL': '1', 14:18:01 INFO - 'TERM': 'linux', 14:18:01 INFO - 'TMOUT': '86400', 14:18:01 INFO - 'USER': 'cltbld', 14:18:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:01 INFO - '_': '/tools/buildbot/bin/python'} 14:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:18:02 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 14:18:02 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 14:18:02 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 14:18:02 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 14:18:02 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 14:18:02 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 14:18:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:18:04 INFO - Installing collected packages: mozsystemmonitor 14:18:04 INFO - Running setup.py install for mozsystemmonitor 14:18:04 INFO - Successfully installed mozsystemmonitor 14:18:04 INFO - Cleaning up... 14:18:04 INFO - Return code: 0 14:18:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:18:04 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')]} 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 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')]} 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:04 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 14:18:04 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 14:18:04 INFO - Using env: {'DISPLAY': ':0', 14:18:04 INFO - 'HOME': '/home/cltbld', 14:18:04 INFO - 'LANG': 'en_US.UTF-8', 14:18:04 INFO - 'LANGUAGE': 'en_US:en', 14:18:04 INFO - 'LOGNAME': 'cltbld', 14:18:04 INFO - 'MAIL': '/var/mail/cltbld', 14:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:04 INFO - 'MOZ_NO_REMOTE': '1', 14:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:04 INFO - 'NO_EM_RESTART': '1', 14:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:04 INFO - 'PWD': '/builds/slave/test', 14:18:04 INFO - 'SHELL': '/bin/bash', 14:18:04 INFO - 'SHLVL': '1', 14:18:04 INFO - 'TERM': 'linux', 14:18:04 INFO - 'TMOUT': '86400', 14:18:04 INFO - 'USER': 'cltbld', 14:18:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:04 INFO - '_': '/tools/buildbot/bin/python'} 14:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:04 INFO - Downloading/unpacking jsonschema==2.5.1 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:18:06 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 14:18:06 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 14:18:06 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 14:18:06 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 14:18:06 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 14:18:06 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 14:18:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:06 INFO - warning: no files found matching '*.txt' 14:18:06 INFO - no previously-included directories found matching 'build' 14:18:06 INFO - no previously-included directories found matching 'dist' 14:18:06 INFO - no previously-included directories found matching '.git*' 14:18:06 INFO - Installing collected packages: jsonschema, functools32 14:18:06 INFO - Running setup.py install for functools32 14:18:06 INFO - warning: no files found matching '*.txt' 14:18:06 INFO - no previously-included directories found matching 'build' 14:18:06 INFO - no previously-included directories found matching 'dist' 14:18:06 INFO - no previously-included directories found matching '.git*' 14:18:06 INFO - Successfully installed jsonschema functools32 14:18:06 INFO - Cleaning up... 14:18:06 INFO - Return code: 0 14:18:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:06 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')]} 14:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:06 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')]} 14:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:06 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:06 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 14:18:06 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 14:18:06 INFO - Using env: {'DISPLAY': ':0', 14:18:06 INFO - 'HOME': '/home/cltbld', 14:18:06 INFO - 'LANG': 'en_US.UTF-8', 14:18:06 INFO - 'LANGUAGE': 'en_US:en', 14:18:06 INFO - 'LOGNAME': 'cltbld', 14:18:06 INFO - 'MAIL': '/var/mail/cltbld', 14:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:06 INFO - 'MOZ_NO_REMOTE': '1', 14:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:06 INFO - 'NO_EM_RESTART': '1', 14:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:06 INFO - 'PWD': '/builds/slave/test', 14:18:06 INFO - 'SHELL': '/bin/bash', 14:18:06 INFO - 'SHLVL': '1', 14:18:06 INFO - 'TERM': 'linux', 14:18:06 INFO - 'TMOUT': '86400', 14:18:06 INFO - 'USER': 'cltbld', 14:18:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:06 INFO - '_': '/tools/buildbot/bin/python'} 14:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:08 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 14:18:08 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 14:18:08 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 14:18:08 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 14:18:08 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 14:18:08 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 14:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:09 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 14:18:09 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 14:18:09 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 14:18:09 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 14:18:09 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 14:18:09 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 14:18:09 INFO - Downloading docopt-0.6.1.tar.gz 14:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:09 INFO - Running setup.py install for blobuploader 14:18:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:09 INFO - Running setup.py install for requests 14:18:10 INFO - Running setup.py install for docopt 14:18:10 INFO - Successfully installed blobuploader requests docopt 14:18:10 INFO - Cleaning up... 14:18:10 INFO - Return code: 0 14:18:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:10 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')]} 14:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:10 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')]} 14:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:10 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:10 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 14:18:10 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 14:18:10 INFO - Using env: {'DISPLAY': ':0', 14:18:10 INFO - 'HOME': '/home/cltbld', 14:18:10 INFO - 'LANG': 'en_US.UTF-8', 14:18:10 INFO - 'LANGUAGE': 'en_US:en', 14:18:10 INFO - 'LOGNAME': 'cltbld', 14:18:10 INFO - 'MAIL': '/var/mail/cltbld', 14:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:10 INFO - 'MOZ_NO_REMOTE': '1', 14:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:10 INFO - 'NO_EM_RESTART': '1', 14:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:10 INFO - 'PWD': '/builds/slave/test', 14:18:10 INFO - 'SHELL': '/bin/bash', 14:18:10 INFO - 'SHLVL': '1', 14:18:10 INFO - 'TERM': 'linux', 14:18:10 INFO - 'TMOUT': '86400', 14:18:10 INFO - 'USER': 'cltbld', 14:18:10 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:10 INFO - '_': '/tools/buildbot/bin/python'} 14:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:10 INFO - Running setup.py (path:/tmp/pip-2lBENE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:10 INFO - Running setup.py (path:/tmp/pip-OV1_NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:10 INFO - Running setup.py (path:/tmp/pip-JKUEBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:10 INFO - Running setup.py (path:/tmp/pip-XiEj2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:10 INFO - Running setup.py (path:/tmp/pip-0SuQIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:10 INFO - Running setup.py (path:/tmp/pip-uSsTvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:10 INFO - Running setup.py (path:/tmp/pip-WGsbC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:11 INFO - Running setup.py (path:/tmp/pip-72mdGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:11 INFO - Running setup.py (path:/tmp/pip-gawEZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:11 INFO - Running setup.py (path:/tmp/pip-wB870g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:11 INFO - Running setup.py (path:/tmp/pip-KYcuiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:11 INFO - Running setup.py (path:/tmp/pip-6NH9S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:11 INFO - Running setup.py (path:/tmp/pip-_ATAWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:11 INFO - Running setup.py (path:/tmp/pip-ZLfR4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:11 INFO - Running setup.py (path:/tmp/pip-PIh5up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:11 INFO - Running setup.py (path:/tmp/pip-vzSzK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:11 INFO - Running setup.py (path:/tmp/pip-CxR1n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:11 INFO - Running setup.py install for manifestparser 14:18:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:11 INFO - Running setup.py install for mozcrash 14:18:11 INFO - Running setup.py install for mozdebug 14:18:12 INFO - Running setup.py install for mozdevice 14:18:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Running setup.py install for mozfile 14:18:12 INFO - Running setup.py install for mozhttpd 14:18:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Running setup.py install for mozinfo 14:18:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Running setup.py install for mozInstall 14:18:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Running setup.py install for mozleak 14:18:12 INFO - Running setup.py install for mozlog 14:18:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Running setup.py install for moznetwork 14:18:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Running setup.py install for mozprocess 14:18:12 INFO - Running setup.py install for mozprofile 14:18:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for mozrunner 14:18:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for mozscreenshot 14:18:13 INFO - Running setup.py install for moztest 14:18:13 INFO - Running setup.py install for mozversion 14:18:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:13 INFO - Cleaning up... 14:18:13 INFO - Return code: 0 14:18:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:13 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')]} 14:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:13 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')]} 14:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:13 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:13 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 14:18:13 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 14:18:13 INFO - Using env: {'DISPLAY': ':0', 14:18:13 INFO - 'HOME': '/home/cltbld', 14:18:13 INFO - 'LANG': 'en_US.UTF-8', 14:18:13 INFO - 'LANGUAGE': 'en_US:en', 14:18:13 INFO - 'LOGNAME': 'cltbld', 14:18:13 INFO - 'MAIL': '/var/mail/cltbld', 14:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:13 INFO - 'MOZ_NO_REMOTE': '1', 14:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:13 INFO - 'NO_EM_RESTART': '1', 14:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:13 INFO - 'PWD': '/builds/slave/test', 14:18:13 INFO - 'SHELL': '/bin/bash', 14:18:13 INFO - 'SHLVL': '1', 14:18:13 INFO - 'TERM': 'linux', 14:18:13 INFO - 'TMOUT': '86400', 14:18:13 INFO - 'USER': 'cltbld', 14:18:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:13 INFO - '_': '/tools/buildbot/bin/python'} 14:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:13 INFO - Running setup.py (path:/tmp/pip-flm8sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:13 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)) 14:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:13 INFO - Running setup.py (path:/tmp/pip-saz0LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:13 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)) 14:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:13 INFO - Running setup.py (path:/tmp/pip-B5b6Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:13 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)) 14:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:13 INFO - Running setup.py (path:/tmp/pip-i62UAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:14 INFO - Running setup.py (path:/tmp/pip-KDNcPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:14 INFO - Running setup.py (path:/tmp/pip-sv1t7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:14 INFO - Running setup.py (path:/tmp/pip-unWb2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:14 INFO - Running setup.py (path:/tmp/pip-faUCNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:14 INFO - Running setup.py (path:/tmp/pip-pWP6iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:14 INFO - Running setup.py (path:/tmp/pip-TrZ1FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:14 INFO - Running setup.py (path:/tmp/pip-SdnP_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:14 INFO - Running setup.py (path:/tmp/pip-q2rwkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:14 INFO - Running setup.py (path:/tmp/pip-VJGCFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:14 INFO - Running setup.py (path:/tmp/pip-Hh7SQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:14 INFO - Running setup.py (path:/tmp/pip-60rRHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:14 INFO - Running setup.py (path:/tmp/pip-VadyyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:14 INFO - Running setup.py (path:/tmp/pip-KEIA59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:14 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)) 14:18:14 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)) 14:18:14 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)) 14:18:14 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)) 14:18:14 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)) 14:18:14 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)) 14:18:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:14 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 14:18:14 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 14:18:14 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 14:18:14 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 14:18:14 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 14:18:14 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 14:18:16 INFO - Downloading blessings-1.6.tar.gz 14:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:16 INFO - Installing collected packages: blessings 14:18:16 INFO - Running setup.py install for blessings 14:18:17 INFO - Successfully installed blessings 14:18:17 INFO - Cleaning up... 14:18:17 INFO - Return code: 0 14:18:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:17 INFO - Reading from file tmpfile_stdout 14:18:17 INFO - Current package versions: 14:18:17 INFO - argparse == 1.2.1 14:18:17 INFO - blessings == 1.6 14:18:17 INFO - blobuploader == 1.2.4 14:18:17 INFO - docopt == 0.6.1 14:18:17 INFO - functools32 == 3.2.3-2 14:18:17 INFO - jsonschema == 2.5.1 14:18:17 INFO - manifestparser == 1.1 14:18:17 INFO - mozInstall == 1.12 14:18:17 INFO - mozcrash == 0.17 14:18:17 INFO - mozdebug == 0.1 14:18:17 INFO - mozdevice == 0.48 14:18:17 INFO - mozfile == 1.2 14:18:17 INFO - mozhttpd == 0.7 14:18:17 INFO - mozinfo == 0.9 14:18:17 INFO - mozleak == 0.1 14:18:17 INFO - mozlog == 3.2 14:18:17 INFO - moznetwork == 0.27 14:18:17 INFO - mozprocess == 0.22 14:18:17 INFO - mozprofile == 0.28 14:18:17 INFO - mozrunner == 6.11 14:18:17 INFO - mozscreenshot == 0.1 14:18:17 INFO - mozsystemmonitor == 0.3 14:18:17 INFO - moztest == 0.7 14:18:17 INFO - mozversion == 1.4 14:18:17 INFO - psutil == 3.1.1 14:18:17 INFO - requests == 1.2.3 14:18:17 INFO - wsgiref == 0.1.2 14:18:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:17 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')]} 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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')]} 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:17 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 14:18:17 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 14:18:17 INFO - Using env: {'DISPLAY': ':0', 14:18:17 INFO - 'HOME': '/home/cltbld', 14:18:17 INFO - 'LANG': 'en_US.UTF-8', 14:18:17 INFO - 'LANGUAGE': 'en_US:en', 14:18:17 INFO - 'LOGNAME': 'cltbld', 14:18:17 INFO - 'MAIL': '/var/mail/cltbld', 14:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:17 INFO - 'MOZ_NO_REMOTE': '1', 14:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:17 INFO - 'NO_EM_RESTART': '1', 14:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:17 INFO - 'PWD': '/builds/slave/test', 14:18:17 INFO - 'SHELL': '/bin/bash', 14:18:17 INFO - 'SHLVL': '1', 14:18:17 INFO - 'TERM': 'linux', 14:18:17 INFO - 'TMOUT': '86400', 14:18:17 INFO - 'USER': 'cltbld', 14:18:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:17 INFO - '_': '/tools/buildbot/bin/python'} 14:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 INFO - Cleaning up... 14:18:17 INFO - Return code: 0 14:18:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:17 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')]} 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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')]} 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:17 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 14:18:17 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 14:18:17 INFO - Using env: {'DISPLAY': ':0', 14:18:17 INFO - 'HOME': '/home/cltbld', 14:18:17 INFO - 'LANG': 'en_US.UTF-8', 14:18:17 INFO - 'LANGUAGE': 'en_US:en', 14:18:17 INFO - 'LOGNAME': 'cltbld', 14:18:17 INFO - 'MAIL': '/var/mail/cltbld', 14:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:17 INFO - 'MOZ_NO_REMOTE': '1', 14:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:17 INFO - 'NO_EM_RESTART': '1', 14:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:17 INFO - 'PWD': '/builds/slave/test', 14:18:17 INFO - 'SHELL': '/bin/bash', 14:18:17 INFO - 'SHLVL': '1', 14:18:17 INFO - 'TERM': 'linux', 14:18:17 INFO - 'TMOUT': '86400', 14:18:17 INFO - 'USER': 'cltbld', 14:18:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:17 INFO - '_': '/tools/buildbot/bin/python'} 14:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:18:17 INFO - Cleaning up... 14:18:17 INFO - Return code: 0 14:18:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:18:17 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')]} 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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')]} 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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 0x7fd11fd78f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', '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 14:18:17 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 14:18:17 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 14:18:17 INFO - Using env: {'DISPLAY': ':0', 14:18:17 INFO - 'HOME': '/home/cltbld', 14:18:17 INFO - 'LANG': 'en_US.UTF-8', 14:18:17 INFO - 'LANGUAGE': 'en_US:en', 14:18:17 INFO - 'LOGNAME': 'cltbld', 14:18:17 INFO - 'MAIL': '/var/mail/cltbld', 14:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:17 INFO - 'MOZ_NO_REMOTE': '1', 14:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:17 INFO - 'NO_EM_RESTART': '1', 14:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:17 INFO - 'PWD': '/builds/slave/test', 14:18:17 INFO - 'SHELL': '/bin/bash', 14:18:17 INFO - 'SHLVL': '1', 14:18:17 INFO - 'TERM': 'linux', 14:18:17 INFO - 'TMOUT': '86400', 14:18:17 INFO - 'USER': 'cltbld', 14:18:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:17 INFO - '_': '/tools/buildbot/bin/python'} 14:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:18 INFO - Downloading/unpacking flake8 14:18:18 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 14:18:18 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 14:18:18 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 14:18:18 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 14:18:18 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 14:18:18 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 14:18:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:20 INFO - no previously-included directories found matching 'docs/_build' 14:18:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:20 INFO - Running setup.py install for pep8 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:20 INFO - no previously-included directories found matching 'docs/_build' 14:18:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:20 INFO - Cleaning up... 14:18:20 INFO - Return code: 0 14:18:20 INFO - Running post-action listener: _resource_record_post_action 14:18:20 INFO - Running post-action listener: _start_resource_monitoring 14:18:20 INFO - Starting resource monitoring. 14:18:20 INFO - ##### 14:18:20 INFO - ##### Finished create-virtualenv step (success) 14:18:20 INFO - ##### 14:18:20 INFO - ##### 14:18:20 INFO - ##### Running install step. 14:18:20 INFO - ##### 14:18:20 INFO - Running pre-action listener: _resource_record_pre_action 14:18:20 INFO - Running main action method: install 14:18:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:21 INFO - Reading from file tmpfile_stdout 14:18:21 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:21 INFO - Reading from file tmpfile_stdout 14:18:21 INFO - Output received: 14:18:21 INFO - Usage: mozinstall [options] installer 14:18:21 INFO - Options: 14:18:21 INFO - -h, --help show this help message and exit 14:18:21 INFO - -d DEST, --destination=DEST 14:18:21 INFO - Directory to install application into. [default: 14:18:21 INFO - "/builds/slave/test"] 14:18:21 INFO - --app=APP Application being installed. [default: firefox] 14:18:21 INFO - mkdir: /builds/slave/test/build/application 14:18:21 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'] 14:18:21 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 14:18:38 INFO - Reading from file tmpfile_stdout 14:18:38 INFO - Output received: 14:18:38 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:38 INFO - Running post-action listener: _resource_record_post_action 14:18:38 INFO - ##### 14:18:38 INFO - ##### Finished install step (success) 14:18:38 INFO - ##### 14:18:38 INFO - ##### 14:18:38 INFO - ##### Running run-tests step. 14:18:38 INFO - ##### 14:18:38 INFO - Running pre-action listener: _resource_record_pre_action 14:18:38 INFO - Running main action method: run_tests 14:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:38 INFO - Python 2.7.3 14:18:38 INFO - Return code: 0 14:18:38 INFO - grabbing minidump binary from tooltool 14:18:38 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')]} 14:18:38 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 0x11d81c0>, '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 0x11d90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:38 INFO - Return code: 0 14:18:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:18:39 INFO - Return code: 0 14:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 14:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 14:18:39 INFO - Using env: {'DISPLAY': ':0', 14:18:39 INFO - 'HOME': '/home/cltbld', 14:18:39 INFO - 'LANG': 'en_US.UTF-8', 14:18:39 INFO - 'LANGUAGE': 'en_US:en', 14:18:39 INFO - 'LOGNAME': 'cltbld', 14:18:39 INFO - 'MAIL': '/var/mail/cltbld', 14:18:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:39 INFO - 'MOZ_NO_REMOTE': '1', 14:18:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:39 INFO - 'NO_EM_RESTART': '1', 14:18:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:39 INFO - 'PWD': '/builds/slave/test', 14:18:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:39 INFO - 'SHELL': '/bin/bash', 14:18:39 INFO - 'SHLVL': '1', 14:18:39 INFO - 'TERM': 'linux', 14:18:39 INFO - 'TMOUT': '86400', 14:18:39 INFO - 'USER': 'cltbld', 14:18:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461', 14:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:39 INFO - '_': '/tools/buildbot/bin/python'} 14:18:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 14:18:39 INFO - mozversion application_buildid: 20160613113007 14:18:39 INFO - mozversion application_changeset: ea5833a015a141c08d9d63b768841af97287033f 14:18:39 INFO - mozversion application_display_name: Nightly 14:18:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:39 INFO - mozversion application_name: Firefox 14:18:39 INFO - mozversion application_remotingname: firefox 14:18:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:18:39 INFO - mozversion application_vendor: Mozilla 14:18:39 INFO - mozversion application_version: 50.0a1 14:18:39 INFO - mozversion platform_buildid: 20160613113007 14:18:39 INFO - mozversion platform_changeset: ea5833a015a141c08d9d63b768841af97287033f 14:18:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:18:39 INFO - mozversion platform_version: 50.0a1 14:18:39 INFO - using testdate: 1465852719 14:18:39 INFO - actual date: 1465852719 14:18:39 INFO - starting webserver on 'localhost:44575' 14:18:39 INFO - SUITE-START | Running 2 tests 14:18:39 INFO - TEST-START | dromaeo_css 14:18:39 INFO - operating with platform_type : linux_ 14:18:39 INFO - Initialising browser for dromaeo_css test... 14:18:39 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV7nSaW/profile http://localhost:44575/getInfo.html) 14:18:46 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 14:18:46 INFO - PROCESS | 3340 | colorDepth:24 14:18:46 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 14:18:46 INFO - PROCESS | 3340 | __metrics 14:18:47 ERROR - PROCESS | 3340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:18:48 INFO - TEST-INFO | 3340: exit 0 14:18:48 INFO - Browser initialized. 14:18:48 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:48 INFO - TEST-INFO | started process 3460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV7nSaW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:00 INFO - PROCESS | 3460 | RSS: Main: 184811520 14:19:00 INFO - PROCESS | 3460 | 14:19:49 INFO - PROCESS | 3460 | 1465852789814 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] 14:21:57 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:44575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44575/tests/dromaeo/cssquery-ext.html) 14:21:58 INFO - PROCESS | 3460 | RSS: Main: 189186048 14:21:58 INFO - PROCESS | 3460 | 14:25:01 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:44575/tests/dromaeo/cssquery-ext.html (next: http://localhost:44575/tests/dromaeo/cssquery-jquery.html) 14:25:01 INFO - PROCESS | 3460 | RSS: Main: 187740160 14:25:01 INFO - PROCESS | 3460 | 14:28:03 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:44575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44575/tests/dromaeo/cssquery-mootools.html) 14:28:04 INFO - PROCESS | 3460 | RSS: Main: 188686336 14:28:04 INFO - PROCESS | 3460 | 14:31:06 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:44575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44575/tests/dromaeo/cssquery-prototype.html) 14:31:06 INFO - PROCESS | 3460 | RSS: Main: 186048512 14:31:06 INFO - PROCESS | 3460 | 14:34:09 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:44575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44575/tests/dromaeo/cssquery-yui.html) 14:34:09 INFO - PROCESS | 3460 | RSS: Main: 188162048 14:34:09 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | Cycle 1(1): loaded http://localhost:44575/tests/dromaeo/cssquery-yui.html (next: http://localhost:44575/tests/dromaeo/cssquery-dojo.html) 14:37:12 INFO - PROCESS | 3460 | RSS: Main: 189120512 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | __start_tp_report 14:37:12 INFO - PROCESS | 3460 | _x_x_mozilla_page_load 14:37:12 INFO - PROCESS | 3460 | _x_x_mozilla_page_load_details 14:37:12 INFO - PROCESS | 3460 | |i|pagename|runs| 14:37:12 INFO - PROCESS | 3460 | |0;dojo.html;3086.166734981555;3118.9844050779743;3119.12664453953;3120.4539205639007;3131.1076343242175;5325.733713314334;5336.786528538859;5365.651232669874;5427.565794736422;5497.972510137453;5264.710440925757;5358.812441564546;5365.087935051041;5431.809886653968;5444.537214336786;4811.855644330667;4824.17988941879;4910.263460480921;4974.228994505857;4991.800327986876;4841.7821198045995;5044.4955504449445;5090.465501122384;5092.465291144432;5099.184130539114;4846.87882802931;4871.14754917888;4880.121578115938;4901.754912254373;4905.411350637911;4923.507649235084;4928.408590969071;4937.654364194508;4941.629377796644;5006.424261209971;4939.604831613462;4940.2342636891335;4954.3063971044085;4966.602671786284;4993.375828021497;5190.169572868323;5223.477652234784;5269.473052694738;5283.101872681654;5352.759125839347;5670.149477578355;5688.800891968761;5716.771329146829;5759.913601295984;5760.164776107483;5608.971955140239;5742.138679198112;5747.712614369307;5750.223719797816;5755.165501002331;5283.498067683564;5300.443453437372;5382.865428364283;5423.810166644149;5428.4300148484235;5844.590878638454;5875.41245875409;5876.177335173079;5890.998530249868;5901.0558310670085;5594.580406469531;5608;5665.1502274658305;5691.630044047207;5704.34400043992;5710.114932185518;5760.0783874579865;5764.250647415809;5771.163181338767;5824.708764561839;5545.861353466115;5573.5819813514145;5620.4660557247;5717;5735.283089613798;5560.471755183251;5647.774089036392;5676.801311954062;5686.09022556389;5716.342620598684;4172.749635021908;4177.415161877339;4201.768902710381;4204.348326009474;4232.894177645583;3771.41543060826;3784.280986612535;3794.0894185395305;3815.751976121543;3817.9809100954317;5335.33308336458;5374.946250537523;5452.972735136378;5456.863578410572;5543.695096769636;5694.1458781183155;5734.197212390269;5738.540916726735;5745.741441635137;5764.7117644117625;5433.782648694008;5444.891102177934;5471.945280547223;5482.862928426821;5493.533049690821;4761.095391875532;4812.326274321597;4816.735079570587;4845.854624361275;4853;5969.074793406942;6037.516998640098;6043.395660433922;6056.878862422727;6079.452849243501;5806.390329015392;5847.1229315603;5857.121431785266;5867.559933005127;5872.442117998783;5819.912701309569;5984.16221728967;6004.969975150271;6054.727537260922;6060.212172417558;5685.971570142288;5692.658440493584;5774.2782152230975;5774.94225057744;5775.971120144372;5831.241938547962;5850.765969361348;5861.6189947653265;5875.854208429315;5879.029960056543;5498.972505137449;5619.409961953936;5646;5673.716314184192;5687.687177205128;5522;5600.355959064596;5627.352854421794;5640.774369025193;5696.971515142398;5594.216809646734;5595.748191331319;5610.691411972218;5614.522765564972;5615.438456154352;5470.835874923759;5588.916166257428;5661.57538184646;5703.08750599902;5727.968965586235;5585.748641311069;5606.24315717373;5608.551315894801;5619.157126431068;5623.718814059199 14:37:12 INFO - PROCESS | 3460 | |1;ext.html;580.4224796327654;620.5097972601643;626.7493002798883;643.6138317009795;655.3381085104044;36807.26385472289;41156;41200;41252.58747412525;41378.37932431016;41894.371584426255;41964.58035419645;42209.78895105528;42357.57642423575;42620;8721.912780872173;8814.206721395074;8836.46981181128;8887.377883548153;8919.197272245498;8789;8873.955630221872;8879.644814207424;8885.111488851095;8885.333599979995;8980.326475514363;8995;9017;9018.188363047324;9027.097290270985;8932.374733768638;8932.955335223314;8945.59744811485;8974.326925480582;8974.641014359418;8789.868151977726;8835.690750823755;8855.025947145808;8884.111588841064;8936.46381217129;33685.494717579255;39690.404643930364;39986.80006599978;40084.799576002224;40105.39841902374;3422.9144271393166;3547.5388199533895;3637.527121474218;3745.887623371303;3754.2866855297407;30949.226269343446;31232.843835780903;32226.194345141324;32331.19172020695;32350.676493235;4182;4228.429162063113;4247.936280955788;4358.259095953664;4432.069265454258;316026;319999;320205;320270;320432;35144.47283290753;35175.648243517746;35592;35666.465003024976;36141.27717445689;37612.43581346282;38004;38043.80978095092;38219.61780382161;38299.80850095787;15340.309686064154;15378.3079761411;15444.922775386276;15523;15597.766033509506;13115;13142.60572182836;13147.934260328828;13232.73534529304;13276.203427794364;8716.607752651145;8741.606627701769;8815.515146666867;8860.379773415927;8884.466931984101;3445.448728203475;3451.516787649731;3452.8273586320583;3492.5808902931813;3493.8951831445097;1015.1168483419325;1079.7840431913648;1083.9729006774735;1089.3137323486312;1177.1583317927723;31546.526802097986;31668;31887.84056079705;31909.840450797597;32166.356672866412;1143.1369316166408;1150.5915400033034;1151.3955173533961;1190.6904204906787;1194.4326444938586;16673.749893751603;16935.407260746062;16958.40438277704;17078.57303567396;17106.315747369965;508869;509451;510234;512606;512765;57581.424185757605;58874.411255886895;58945;59095.40904590985;59145.11282330768;1291.6770807298176;1344.9731005379838;1350.8851747601368;1361.251311778518;1386.057480912989;30185.69814301829;34191.82904085464;34792.13019674528;35065.47401788924;37242.44136337903;57481.71259143677;58306.7084664574;58485;62076;62656.686716566124;533060;545294;545517;546886;548424;46361.304580430646;46583;47488;47637.52362476331;48364.27453588128;50615;51486;51890.74054629703;51981;52897.413077607736;42390.78804605957;44038;44092.33861492016;44153.55846441623;44689.77655111704;43189.568104318554;43987.12025759531;44150.33774493449;44171.558284416744;44675;41979.7901010493;42010.369844452965;42126;43143.78428107965;43218.35172472353;37358.62641373552;37584.43623345597;38034.239315214094;38371.80814095912;38755;28415.43169136647;28496.715032849406;28626.284342891595;28718.138455846358;28921.710782891903 14:37:12 INFO - PROCESS | 3460 | |2;jquery.html;399.1916369352062;403.52182663543687;404.629763766154;409.3470913892341;420.85270155445596;13996.93001534991;18978.52553686157;18995.62008759824;19795.40613781587;19916.900415497938;18057.187426565804;18715.71926421105;18730.15714292857;18870.716939245922;19188.808111918912;5342.385625653061;5530.644991976971;5660.2075709400715;5694.060480020812;5788.363280039192;5451.318585176853;5654.717264136797;5675.091985282355;5720.656760594377;5821.825345239649;5786.421357864201;5845.210896528978;5865.765369385241;5873.383294754032;5912.556558258127;5692.288463942007;5704.828855134353;5812.389699081599;5822.155787410802;5835.18307436957;4978.576820970222;5308.203769434577;5381.973090134525;5390.380106287788;5596.188552659842;13690.247036412993;13898.722025559433;14154.150750954976;14270;14348.497802576963;2179.193698331612;2246.3934737620916;2392.3301475586863;2552.438463538019;2916.9207393264414;10550.894491055145;11451.88548114525;13971.79042314366;14762;14873.330700118413;1850.1489314915154;1863.2857770850849;1868.318063906678;1903.6858918278467;1937.5834195647863;77496.22503774946;78890.60554697247;79503;79569.60215198887;80243;9997.950010250048;10279.743006424898;10729.570817167381;10768.138548916068;10874.836877446845;14455.349509272108;14567.125972441687;14570.562883113524;14570.781438278435;14579.489717859824;7232.132144142632;7450.143233528213;7583.696652133964;7743.574103424253;7784.3772498200005;7128.574285142992;7148.142222933177;7351.632418379059;7361.6319184040585;7629.351505122016;4190.638042636156;4249.660027197817;4356.564343565618;4365.563443655609;4410.514843367227;1837.7427160197583;1876.7372567840514;1881.9529511762316;1914.4256722983328;1971.3198946363482;912.8311262416474;961.5769061612868;1004.1815920025156;1086.0822604898847;1090.7327704712395;18961.43115706531;19427.222911083398;19433.805661943483;19508.414747557596;19573.706394404096;995.3977843404781;1006.9295149339622;1052.5579256712047;1071.3357718214602;1119.692084676704;10317.380957142444;10824.4046577439;11029.669109926715;11180.04969577595;11193.552257909756;355555;357870;359083;446491;452344;58589.121163182586;75875;84414.57792710997;85576;87664;1009.0716540782498;1023.4729114506035;1047.7852040331866;1048.9318194317345;1052.2160990062453;17550.648987020442;17646.382491588938;18052.368167114088;18056.368027118988;18387;31204.843975779975;41554;43106.78446607747;43765;43910.78044609757;59133.26933845368;60384.396156037874;61186.38813611807;62042.37957620366;62069.37930620817;8279.54462504568;8884.86672699923;8922.643094276416;8959.910400896168;9046.366754327397;13239.536616218771;13672.52146174919;13698;13746.587602371545;14013.929930350283;11377.20359574855;11562;11883.524659013543;11919.582814601446;11988.76022479528;11011.229213955266;11838.467268972745;11932.940335298268;11936.403179841147;12174.695632609255;11277.887221128012;11309.773804524028;11621.360825154698;11978.76042479163;12052.939735301268;8957.507337096522;9000.36997410175;9080.091990800867;9276.907230927603;9336.299777516577;11327.263727857662;11811.763764724485;11859.762804743685;12039.03687704964;12168.939155304166 14:37:12 INFO - PROCESS | 3460 | |3;mootools.html;1472.2712257432572;1479.35647993123;1621.7486289625106;1749.0555100245867;1757.964840703186;7953.403494737889;8562.357823163264;8591;9138.360314777976;9151.67969121081;8684.261837743783;8791.560421978907;8974.102589741022;8977.371583989123;8985.95507022464;2371.67982322386;2391.964120538193;2392.1149174805346;2394.6408038794234;2396.2212281008656;2316.7104111986;2332.9066837326486;2354.2584086012935;2358.0332063853825;2365.396823809926;2377.940551486209;2378.8334816562847;2384.201292566992;2402.60357041088;2403.230966090852;2259.062489067035;2269.795718385345;2282.3038973113194;2288.061894623205;2340.754220806825;2283.7259528856475;2294.0823670531754;2301.8158547316343;2313.1672597864754;2319.6636487709357;8897.421667591585;8904.8664270036;8945.955270223607;8992.505412202327;9040.547972601344;5242.60680448964;5291.232771248147;5412.512873841373;5412.91880621791;5413.485718856702;3044.58898048765;3214.3410600826774;3217.420864244435;3230.8223047732367;3254.08885512057;990.2127808392345;1013.8175128476871;1030.464158637512;1038.361407734238;1050.5692666006978;11887.40562971848;11964.222325548812;12023.759524809455;12098.334591597459;12114.273143611323;4586.220342541776;4733.976330118397;4736.4316282046375;4744.620430365562;4822.927656085161;10172.491375431198;10187.7453063674;10194.592216311265;10225.233107516966;10306.793864122676;5312.2297266896085;5327.440618735054;5343.70609616467;5347.331583552056;5349.063913815066;4397.6042156206095;4789.4971028042255;4824.324594556765;4976.925346119811;5008.973160502088;4049.6962727794944;4107.414088882562;4150;4180.540140584533;4207.852725154605;1298.104308027458;1306.6415120707024;1326.2307861440343;1328.2827273272517;1332.6601716562216;971.4851128901694;988.7972965542046;1004.8844382895915;1014.8477728340808;1028.92797504174;5814.854628634318;5876.059830427112;5994.940050599525;6064.06007068905;6083.878322433615;461.9145458090264;474.0731869195714;480.6011010860977;484.8812041049965;487.3007234618334;4048.67610591152;4068.8575899843363;4117.114820313647;4153.68847336451;4169.791510424467;10646.254762166574;10895.237333386745;10971.890281097247;11017;11035.779284414266;10780.892191078146;10808.945955270174;10891.074258687942;10924.071453926346;10931.836022459669;8156.2659360656635;8232.518146733526;8358.665653373919;8369.539675317794;8382.287505562095;6106.267247930276;6122.877542449215;6193.81418557444;6211;6236.314005459305;9997.650082247377;10109.545070471699;10112.949435252776;10131.949340253252;10250.436226007641;10058.798824023625;10300.793984120126;10419.218558608287;10470.476476176313;10557.683269501927;7115.181754098138;7688;7925.405594580314;7959.124496305286;8053.23494268067;8875.644974201217;8901.821963560564;8907.554622268732;8949.776255593662;8958.955205224192;7570.772876813704;7682.347000505019;7770.689172433265;7788.805279868048;8132.024157101186;7627.733029343946;7629.38964882797;7740.574268415291;7869.173736757787;7893.97378340812;7101.218865924848;7125.893111603226;7190.96404517974;7191.820204494929;7199.3520583147765;5064.569511591556;5116.334876466036;5285.920711189258;5301.973490132525;5397.703126327932;5384;5486.341639003345;5559.471850174227;5572.052751032254;5662.207290979184 14:37:12 INFO - PROCESS | 3460 | |4;prototype.html;334.14625631511495;344.60886893376016;347.0681220921824;353.98761043363487;355.55733112275203;5483.122700367942;5503.174523821429;5679.642948176507;5699.971500142498;5700.971495142524;5489.972550137254;5504.559635229182;5510.393856675772;5529.3364796224405;5552.5280351170095;4282.8715138545895;4304.503388034947;4312.460942382202;4313;4325.199838029975;4159.875203743893;4312;4330.437043184382;4335.43639326887;4337.587929146726;4255.361695745632;4263.168682106991;4267.274563324227;4281.892952676177;4301.505326887401;4306.7631280279575;4317.76252306123;4326.134773045372;4329.631981281564;4342.218400687875;3640.5801737322467;3759.2293579816346;3797.3671321331817;3814.5041144651295;3818.732688711791;5395.892082158335;5424.647397919122;5440.727963601804;5465.426130256305;5466.753996070186;4883.19427294496;4905.754712264408;4914.729689867056;4922.384701912261;4932.728699921503;5553.555715542747;5747.62640428375;5793.478586927196;5797.420257974211;5815.098659707752;4051.9392209116886;4087.5299340575916;4087.589781525369;4098.610631989956;4105.753654780723;5987.580869339148;6028.6985650717725;6037.396260373971;6039.969800150971;6071.848203794852;4137.358709400048;4179.477565304337;4195.202911446876;4202.138561594927;4243.915121697611;4288.09949910516;4313.503947046067;4317.697761156752;4318.438602981592;4335.024619460659;4937.259411088366;4946.925796112989;4947.925781113287;4957.826476073392;4996.200607902718;5228.4510126436935;5810.099434587646;5890.617109887844;5920.940790592125;5952.821415357546;1489.7392956232616;1496.4537943650707;1502.9624259393383;1503.999840106339;1507.2765072765135;955.6559638530124;968.1818863060703;980.6910823090703;981.3621146254991;982.7051884434641;5021.297018417425;5037.899242015139;5056.216286475602;5095.668781529189;5098.311727916684;5327.254184414185;5332.466753324714;5334.679919204783;5341.118715411913;5395.298611180521;5011.423686276052;5070.847874563695;5087.720175390315;5292.676830792302;5776.913346299725;3177.9841100794347;3191.69678880506;3210.229544909205;3217.951730724041;3219.036387803438;6128.0279064653605;6243.500519958392;6245.812625621239;6260.373962603703;6286.905696414466;6116.327204007555;6139.2325959255095;6139.386061393825;6141.84645383869;6142.662153581596;6125.387461253839;6212.81361559154;6235.127082208403;6252.499800015988;6308.810735677937;5840.269966254218;5947.226860508106;6012.8797424052145;6023.728932198149;6031.788887388921;5836.912446313394;5894.6757928314355;5913.881722365614;5951.256092988377;5992.460678538952;5994.760209591567;6172.22847144107;6203.8833010056815;6218.098375735402;6235.594686345373;4254.149170166041;4262.891648171436;4273.358996150478;4286.571342865688;4292.91414171721;5761.279840019997;5822.4759771619065;6057.091436284416;6074.878502429839;6079.3008803988105;5798.217240672455;5802.47777700009;5835.124731290341;5856.736446859816;5865.178874957424;5818.563607729353;5823.242978412779;5838.824835254949;5859.355470898113;5910.4089591042275;5531.137536772235;5702.857428564153;5708.429157084258;5756.1941328214925;5763.394843541368;5816.621919575214;5817.360090390139;5859.945209862266;5898.4101589840675;5903.203067585821;5510.732531517693;5670.631408958405;5706.3152421709665;5818.6217895836635;5832.708364581838 14:37:12 INFO - PROCESS | 3460 | |5;yui.html;724.2033762860854;767.7428061599361;788.5150632361098;790.1854809598923;832.5004997001796;15103.924480377596;16023.11872846993;16355.264013119408;16361.509154725347;16389.754153687703;14911.552653420387;15016.324265408055;15079.924600376982;15108.924455377735;15190.620234494143;680.4148432348202;809.9878501822462;827.9420440569163;829.0176141272581;829.0465964141225;796.9203079692013;814.8859159717645;816.8529664660359;818.979525511861;821.765796747927;852.3564708644965;869.2003356911625;870.3559366069095;870.7605408512678;870.9085546017672;846.1031306814765;854.2567965869671;855.1576696953526;856.755824589992;856.7686724584389;622.4024936061387;628.5160426471637;628.6008384675719;629.5247088448192;631.1101347100566;14551.126932383984;14584.343704533321;14643.92678036603;14647.853521464756;14735.705285894222;15327.080375177413;15335.693286134216;15345.693086138326;15470.381184752596;15488.767668484981;11575.47910344028;11892.079207920791;11898.940505297505;12183;12326;3758.285925674113;3788.204477059821;3799.44251078095;3813.599572044951;3957.386605076189;67235.66382168057;70720.29279707189;71818.2818171822;73116.6344168281;74043.25956740418;11622.476988535536;11875.703107422383;12125.696857578454;12181.208221465753;12323.69190770238;22954.19660311881;23020.65469017966;23194;23326.416839578807;23743.287701368987;8816.294696424271;8989.730308090768;9074.909250907538;9133.588988495534;9394.107559781809;4793.400824896888;4837.22604383304;4884.462709101996;4888.877778055506;4957.008598280287;3570.321638888603;3683.060819491013;3694.815259237081;3712.7029837612927;3714.7213958953184;656.7865443730807;658.6904155047121;671.2951401028997;674.6694119881321;681.9079424277759;636.5512313818747;640.9006603976391;661.4311691944923;683.733343995842;698.5005720909573;9751.561179746786;9884.24398728493;9911.256655750847;10330.328528645614;10560.366378017343;612.8621060261495;678.1827897383641;678.2369833936821;693.9618320992292;712.4727701500956;4672.556107169813;4909.386326709161;4930.112579735682;4955.821166880618;5011.09800235961;119421.40289298497;120404;120826.39586802185;124909.37545312397;126071.36964315119;103174.48412757888;104303.4784826071;106033;106380.46809765902;107485.46257268664;55766.72116639391;57118.42881571131;67248.66375668091;80787;87157.99999999873;9397.252481299578;9406.905930940877;9465.621375144918;9565.882252994614;9614.375065620712;50411.74794126006;51134.23298650449;51898.74050629874;53444.19833702575;53887;50119;73698;74517;75330;75345.62327188549;12397.194182378116;12907.935460322638;12924.870751292367;12933.482660693468;13357.599272021855;13223.603291901258;13590.524331648345;14061.36723847409;14169.787453188417;14181.432742690176;12673.93663031716;12748.171368860994;12998.480060797841;13010.154339967872;13025.934870325587;12488.500459981498;12495.375231238584;12892.806607901077;13258.204507729568;13839.515616953358;13181.40683669218;13345.332733363099;13396.665083372603;13426.261555614536;13521.526746563823;10728.517216725422;10838.729031774268;10909.83635245456;10984.450777461256;11484.94257528707;10769.138468922623;10861.837072444077;11185.398902344363;11201.66395008151;11269.66191014271 14:37:12 INFO - PROCESS | 3460 | __end_tp_report 14:37:12 INFO - PROCESS | 3460 | __start_cc_report 14:37:12 INFO - PROCESS | 3460 | _x_x_mozilla_cycle_collect,358 14:37:12 INFO - PROCESS | 3460 | __end_cc_report 14:37:12 INFO - PROCESS | 3460 | __startTimestamp1465853832642__endTimestamp 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | ------- Summary: start ------- 14:37:12 INFO - PROCESS | 3460 | Number of tests: 6 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | [#0] dojo.html Cycles:165 Average:5341.49 Median:5588.92 stddev:629.69 (11.3%) stddev-sans-first:606.26 14:37:12 INFO - PROCESS | 3460 | Values: 3086.2 3119.0 3119.1 3120.5 3131.1 5325.7 5336.8 5365.7 5427.6 5498.0 5264.7 5358.8 5365.1 5431.8 5444.5 4811.9 4824.2 4910.3 4974.2 4991.8 4841.8 5044.5 5090.5 5092.5 5099.2 4846.9 4871.1 4880.1 4901.8 4905.4 4923.5 4928.4 4937.7 4941.6 5006.4 4939.6 4940.2 4954.3 4966.6 4993.4 5190.2 5223.5 5269.5 5283.1 5352.8 5670.1 5688.8 5716.8 5759.9 5760.2 5609.0 5742.1 5747.7 5750.2 5755.2 5283.5 5300.4 5382.9 5423.8 5428.4 5844.6 5875.4 5876.2 5891.0 5901.1 5594.6 5608.0 5665.2 5691.6 5704.3 5710.1 5760.1 5764.3 5771.2 5824.7 5545.9 5573.6 5620.5 5717.0 5735.3 5560.5 5647.8 5676.8 5686.1 5716.3 4172.7 4177.4 4201.8 4204.3 4232.9 3771.4 3784.3 3794.1 3815.8 3818.0 5335.3 5374.9 5453.0 5456.9 5543.7 5694.1 5734.2 5738.5 5745.7 5764.7 5433.8 5444.9 5471.9 5482.9 5493.5 4761.1 4812.3 4816.7 4845.9 4853.0 5969.1 6037.5 6043.4 6056.9 6079.5 5806.4 5847.1 5857.1 5867.6 5872.4 5819.9 5984.2 6005.0 6054.7 6060.2 5686.0 5692.7 5774.3 5774.9 5776.0 5831.2 5850.8 5861.6 5875.9 5879.0 5499.0 5619.4 5646.0 5673.7 5687.7 5522.0 5600.4 5627.4 5640.8 5697.0 5594.2 5595.7 5610.7 5614.5 5615.4 5470.8 5588.9 5661.6 5703.1 5728.0 5585.7 5606.2 5608.6 5619.2 5623.7 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | [#1] ext.html Cycles:180 Average:60999.55 Median:23038.19 stddev:124699.86 (541.3%) stddev-sans-first:124967.16 14:37:12 INFO - PROCESS | 3460 | Values: 580.4 620.5 626.7 643.6 655.3 36807.3 41156.0 41200.0 41252.6 41378.4 41894.4 41964.6 42209.8 42357.6 42620.0 8721.9 8814.2 8836.5 8887.4 8919.2 8789.0 8874.0 8879.6 8885.1 8885.3 8980.3 8995.0 9017.0 9018.2 9027.1 8932.4 8933.0 8945.6 8974.3 8974.6 8789.9 8835.7 8855.0 8884.1 8936.5 33685.5 39690.4 39986.8 40084.8 40105.4 3422.9 3547.5 3637.5 3745.9 3754.3 30949.2 31232.8 32226.2 32331.2 32350.7 4182.0 4228.4 4247.9 4358.3 4432.1 316026.0 319999.0 320205.0 320270.0 320432.0 35144.5 35175.6 35592.0 35666.5 36141.3 37612.4 38004.0 38043.8 38219.6 38299.8 15340.3 15378.3 15444.9 15523.0 15597.8 13115.0 13142.6 13147.9 13232.7 13276.2 8716.6 8741.6 8815.5 8860.4 8884.5 3445.4 3451.5 3452.8 3492.6 3493.9 1015.1 1079.8 1084.0 1089.3 1177.2 31546.5 31668.0 31887.8 31909.8 32166.4 1143.1 1150.6 1151.4 1190.7 1194.4 16673.7 16935.4 16958.4 17078.6 17106.3 508869.0 509451.0 510234.0 512606.0 512765.0 57581.4 58874.4 58945.0 59095.4 59145.1 1291.7 1345.0 1350.9 1361.3 1386.1 30185.7 34191.8 34792.1 35065.5 37242.4 57481.7 58306.7 58485.0 62076.0 62656.7 533060.0 545294.0 545517.0 546886.0 548424.0 46361.3 46583.0 47488.0 47637.5 48364.3 50615.0 51486.0 51890.7 51981.0 52897.4 42390.8 44038.0 44092.3 44153.6 44689.8 43189.6 43987.1 44150.3 44171.6 44675.0 41979.8 42010.4 42126.0 43143.8 43218.4 37358.6 37584.4 38034.2 38371.8 38755.0 28415.4 28496.7 28626.3 28718.1 28921.7 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | [#2] jquery.html Cycles:180 Average:25746.14 Median:11048.05 stddev:65790.23 (595.5%) stddev-sans-first:65947.27 14:37:12 INFO - PROCESS | 3460 | Values: 399.2 403.5 404.6 409.3 420.9 13996.9 18978.5 18995.6 19795.4 19916.9 18057.2 18715.7 18730.2 18870.7 19188.8 5342.4 5530.6 5660.2 5694.1 5788.4 5451.3 5654.7 5675.1 5720.7 5821.8 5786.4 5845.2 5865.8 5873.4 5912.6 5692.3 5704.8 5812.4 5822.2 5835.2 4978.6 5308.2 5382.0 5390.4 5596.2 13690.2 13898.7 14154.2 14270.0 14348.5 2179.2 2246.4 2392.3 2552.4 2916.9 10550.9 11451.9 13971.8 14762.0 14873.3 1850.1 1863.3 1868.3 1903.7 1937.6 77496.2 78890.6 79503.0 79569.6 80243.0 9998.0 10279.7 10729.6 10768.1 10874.8 14455.3 14567.1 14570.6 14570.8 14579.5 7232.1 7450.1 7583.7 7743.6 7784.4 7128.6 7148.1 7351.6 7361.6 7629.4 4190.6 4249.7 4356.6 4365.6 4410.5 1837.7 1876.7 1882.0 1914.4 1971.3 912.8 961.6 1004.2 1086.1 1090.7 18961.4 19427.2 19433.8 19508.4 19573.7 995.4 1006.9 1052.6 1071.3 1119.7 10317.4 10824.4 11029.7 11180.0 11193.6 355555.0 357870.0 359083.0 446491.0 452344.0 58589.1 75875.0 84414.6 85576.0 87664.0 1009.1 1023.5 1047.8 1048.9 1052.2 17550.6 17646.4 18052.4 18056.4 18387.0 31204.8 41554.0 43106.8 43765.0 43910.8 59133.3 60384.4 61186.4 62042.4 62069.4 8279.5 8884.9 8922.6 8959.9 9046.4 13239.5 13672.5 13698.0 13746.6 14013.9 11377.2 11562.0 11883.5 11919.6 11988.8 11011.2 11838.5 11932.9 11936.4 12174.7 11277.9 11309.8 11621.4 11978.8 12052.9 8957.5 9000.4 9080.1 9276.9 9336.3 11327.3 11811.8 11859.8 12039.0 12168.9 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | [#3] mootools.html Cycles:180 Average:5844.54 Median:2605.25 stddev:3318.21 (127.4%) stddev-sans-first:3311.25 14:37:12 INFO - PROCESS | 3460 | Values: 1472.3 1479.4 1621.7 1749.1 1758.0 7953.4 8562.4 8591.0 9138.4 9151.7 8684.3 8791.6 8974.1 8977.4 8986.0 2371.7 2392.0 2392.1 2394.6 2396.2 2316.7 2332.9 2354.3 2358.0 2365.4 2377.9 2378.8 2384.2 2402.6 2403.2 2259.1 2269.8 2282.3 2288.1 2340.8 2283.7 2294.1 2301.8 2313.2 2319.7 8897.4 8904.9 8946.0 8992.5 9040.5 5242.6 5291.2 5412.5 5412.9 5413.5 3044.6 3214.3 3217.4 3230.8 3254.1 990.2 1013.8 1030.5 1038.4 1050.6 11887.4 11964.2 12023.8 12098.3 12114.3 4586.2 4734.0 4736.4 4744.6 4822.9 10172.5 10187.7 10194.6 10225.2 10306.8 5312.2 5327.4 5343.7 5347.3 5349.1 4397.6 4789.5 4824.3 4976.9 5009.0 4049.7 4107.4 4150.0 4180.5 4207.9 1298.1 1306.6 1326.2 1328.3 1332.7 971.5 988.8 1004.9 1014.8 1028.9 5814.9 5876.1 5994.9 6064.1 6083.9 461.9 474.1 480.6 484.9 487.3 4048.7 4068.9 4117.1 4153.7 4169.8 10646.3 10895.2 10971.9 11017.0 11035.8 10780.9 10808.9 10891.1 10924.1 10931.8 8156.3 8232.5 8358.7 8369.5 8382.3 6106.3 6122.9 6193.8 6211.0 6236.3 9997.7 10109.5 10112.9 10131.9 10250.4 10058.8 10300.8 10419.2 10470.5 10557.7 7115.2 7688.0 7925.4 7959.1 8053.2 8875.6 8901.8 8907.6 8949.8 8959.0 7570.8 7682.3 7770.7 7788.8 8132.0 7627.7 7629.4 7740.6 7869.2 7894.0 7101.2 7125.9 7191.0 7191.8 7199.4 5064.6 5116.3 5285.9 5302.0 5397.7 5384.0 5486.3 5559.5 5572.1 5662.2 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | [#4] prototype.html Cycles:180 Average:4862.14 Median:5486.55 stddev:1433.94 (26.1%) stddev-sans-first:1397.11 14:37:12 INFO - PROCESS | 3460 | Values: 334.1 344.6 347.1 354.0 355.6 5483.1 5503.2 5679.6 5700.0 5701.0 5490.0 5504.6 5510.4 5529.3 5552.5 4282.9 4304.5 4312.5 4313.0 4325.2 4159.9 4312.0 4330.4 4335.4 4337.6 4255.4 4263.2 4267.3 4281.9 4301.5 4306.8 4317.8 4326.1 4329.6 4342.2 3640.6 3759.2 3797.4 3814.5 3818.7 5395.9 5424.6 5440.7 5465.4 5466.8 4883.2 4905.8 4914.7 4922.4 4932.7 5553.6 5747.6 5793.5 5797.4 5815.1 4051.9 4087.5 4087.6 4098.6 4105.8 5987.6 6028.7 6037.4 6040.0 6071.8 4137.4 4179.5 4195.2 4202.1 4243.9 4288.1 4313.5 4317.7 4318.4 4335.0 4937.3 4946.9 4947.9 4957.8 4996.2 5228.5 5810.1 5890.6 5920.9 5952.8 1489.7 1496.5 1503.0 1504.0 1507.3 955.7 968.2 980.7 981.4 982.7 5021.3 5037.9 5056.2 5095.7 5098.3 5327.3 5332.5 5334.7 5341.1 5395.3 5011.4 5070.8 5087.7 5292.7 5776.9 3178.0 3191.7 3210.2 3218.0 3219.0 6128.0 6243.5 6245.8 6260.4 6286.9 6116.3 6139.2 6139.4 6141.8 6142.7 6125.4 6212.8 6235.1 6252.5 6308.8 5840.3 5947.2 6012.9 6023.7 6031.8 5836.9 5894.7 5913.9 5951.3 5992.5 5994.8 6172.2 6203.9 6218.1 6235.6 4254.1 4262.9 4273.4 4286.6 4292.9 5761.3 5822.5 6057.1 6074.9 6079.3 5798.2 5802.5 5835.1 5856.7 5865.2 5818.6 5823.2 5838.8 5859.4 5910.4 5531.1 5702.9 5708.4 5756.2 5763.4 5816.6 5817.4 5859.9 5898.4 5903.2 5510.7 5670.6 5706.3 5818.6 5832.7 14:37:12 INFO - PROCESS | 3460 | 14:37:12 INFO - PROCESS | 3460 | [#5] yui.html Cycles:180 Average:20552.04 Median:3885.49 stddev:29862.16 (768.6%) stddev-sans-first:29908.81 14:37:12 INFO - PROCESS | 3460 | Values: 724.2 767.7 788.5 790.2 832.5 15103.9 16023.1 16355.3 16361.5 16389.8 14911.6 15016.3 15079.9 15108.9 15190.6 680.4 810.0 827.9 829.0 829.0 796.9 814.9 816.9 819.0 821.8 852.4 869.2 870.4 870.8 870.9 846.1 854.3 855.2 856.8 856.8 622.4 628.5 628.6 629.5 631.1 14551.1 14584.3 14643.9 14647.9 14735.7 15327.1 15335.7 15345.7 15470.4 15488.8 11575.5 11892.1 11898.9 12183.0 12326.0 3758.3 3788.2 3799.4 3813.6 3957.4 67235.7 70720.3 71818.3 73116.6 74043.3 11622.5 11875.7 12125.7 12181.2 12323.7 22954.2 23020.7 23194.0 23326.4 23743.3 8816.3 8989.7 9074.9 9133.6 9394.1 4793.4 4837.2 4884.5 4888.9 4957.0 3570.3 3683.1 3694.8 3712.7 3714.7 656.8 658.7 671.3 674.7 681.9 636.6 640.9 661.4 683.7 698.5 9751.6 9884.2 9911.3 10330.3 10560.4 612.9 678.2 678.2 694.0 712.5 4672.6 4909.4 4930.1 4955.8 5011.1 119421.4 120404.0 120826.4 124909.4 126071.4 103174.5 104303.5 106033.0 106380.5 107485.5 55766.7 57118.4 67248.7 80787.0 87158.0 9397.3 9406.9 9465.6 9565.9 9614.4 50411.7 51134.2 51898.7 53444.2 53887.0 50119.0 73698.0 74517.0 75330.0 75345.6 12397.2 12907.9 12924.9 12933.5 13357.6 13223.6 13590.5 14061.4 14169.8 14181.4 12673.9 12748.2 12998.5 13010.2 13025.9 12488.5 12495.4 12892.8 13258.2 13839.5 13181.4 13345.3 13396.7 13426.3 13521.5 10728.5 10838.7 10909.8 10984.5 11484.9 10769.1 10861.8 11185.4 11201.7 11269.7 14:37:12 INFO - PROCESS | 3460 | -------- Summary: end -------- 14:37:12 INFO - PROCESS | 3460 | 14:37:13 INFO - TEST-INFO | 3460: exit 0 14:37:13 INFO - TEST-OK | dromaeo_css | took 1113765ms 14:37:13 INFO - TEST-START | kraken 14:37:13 INFO - operating with platform_type : linux_ 14:37:13 INFO - Initialising browser for kraken test... 14:37:13 INFO - TEST-INFO | started process 3688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAej66m/profile http://localhost:44575/getInfo.html) 14:37:18 INFO - PROCESS | 3688 | __metrics Screen width/height:1600/1200 14:37:18 INFO - PROCESS | 3688 | colorDepth:24 14:37:18 INFO - PROCESS | 3688 | Browser inner width/height: 1024/697 14:37:18 INFO - PROCESS | 3688 | __metrics 14:37:19 ERROR - PROCESS | 3688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:37:20 INFO - TEST-INFO | 3688: exit 0 14:37:20 INFO - Browser initialized. 14:37:20 INFO - Running cycle 1/1 for kraken test... 14:37:20 INFO - TEST-INFO | started process 3806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAej66m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:32 INFO - PROCESS | 3806 | RSS: Main: 184467456 14:37:32 INFO - PROCESS | 3806 | 14:37:34 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44575/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:35 INFO - PROCESS | 3806 | RSS: Main: 190062592 14:37:35 INFO - PROCESS | 3806 | 14:37:38 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44575/tests/kraken/driver.html?testName=audio-dft) 14:37:38 INFO - PROCESS | 3806 | RSS: Main: 189665280 14:37:38 INFO - PROCESS | 3806 | 14:37:41 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44575/tests/kraken/driver.html?testName=audio-fft) 14:37:42 INFO - PROCESS | 3806 | RSS: Main: 184688640 14:37:42 INFO - PROCESS | 3806 | 14:37:44 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44575/tests/kraken/driver.html?testName=audio-oscillator) 14:37:45 INFO - PROCESS | 3806 | RSS: Main: 184987648 14:37:45 INFO - PROCESS | 3806 | 14:37:47 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:47 INFO - PROCESS | 3806 | RSS: Main: 185409536 14:37:47 INFO - PROCESS | 3806 | 14:37:50 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44575/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:51 INFO - PROCESS | 3806 | RSS: Main: 184815616 14:37:51 INFO - PROCESS | 3806 | 14:37:55 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44575/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:55 INFO - PROCESS | 3806 | RSS: Main: 183230464 14:37:55 INFO - PROCESS | 3806 | 14:37:58 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44575/tests/kraken/driver.html?testName=json-parse-financial) 14:37:59 INFO - PROCESS | 3806 | RSS: Main: 185028608 14:37:59 INFO - PROCESS | 3806 | 14:38:00 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:01 INFO - PROCESS | 3806 | RSS: Main: 185200640 14:38:01 INFO - PROCESS | 3806 | 14:38:03 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:03 INFO - PROCESS | 3806 | RSS: Main: 185462784 14:38:03 INFO - PROCESS | 3806 | 14:38:05 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:06 INFO - PROCESS | 3806 | RSS: Main: 185856000 14:38:06 INFO - PROCESS | 3806 | 14:38:09 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:09 INFO - PROCESS | 3806 | RSS: Main: 185778176 14:38:09 INFO - PROCESS | 3806 | 14:38:12 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:13 INFO - PROCESS | 3806 | RSS: Main: 185462784 14:38:13 INFO - PROCESS | 3806 | 14:38:14 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:44575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44575/tests/kraken/driver.html?testName=ai-astar) 14:38:15 INFO - PROCESS | 3806 | RSS: Main: 186408960 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | __start_tp_report 14:38:15 INFO - PROCESS | 3806 | _x_x_mozilla_page_load 14:38:15 INFO - PROCESS | 3806 | _x_x_mozilla_page_load_details 14:38:15 INFO - PROCESS | 3806 | |i|pagename|runs| 14:38:15 INFO - PROCESS | 3806 | |0;ai-astar;112;106;112;109;112;111;112;110;111;111 14:38:15 INFO - PROCESS | 3806 | |1;audio-beat-detection;158;131;153;176;127;158;151;128;176;126 14:38:15 INFO - PROCESS | 3806 | |2;audio-dft;163;162;163;160;168;177;165;163;163;161 14:38:15 INFO - PROCESS | 3806 | |3;audio-fft;75;75;75;154;77;76;75;76;166;75 14:38:15 INFO - PROCESS | 3806 | |4;audio-oscillator;86;84;152;85;88;84;139;86;85;138 14:38:15 INFO - PROCESS | 3806 | |5;imaging-gaussian-blur;117;117;117;119;117;117;117;117;123;117 14:38:15 INFO - PROCESS | 3806 | |6;imaging-darkroom;147;147;147;146;150;148;147;147;148;146 14:38:15 INFO - PROCESS | 3806 | |7;imaging-desaturate;100;97;96;95;96;96;95;96;96;95 14:38:15 INFO - PROCESS | 3806 | |8;json-parse-financial;52;53;53;53;56;52;52;53;52;52 14:38:15 INFO - PROCESS | 3806 | |9;json-stringify-tinderbox;64;63;61;62;62;63;62;61;62;62 14:38:15 INFO - PROCESS | 3806 | |10;stanford-crypto-aes;83;81;81;81;85;82;82;87;112;84 14:38:15 INFO - PROCESS | 3806 | |11;stanford-crypto-ccm;135;130;122;138;130;132;129;133;133;123 14:38:15 INFO - PROCESS | 3806 | |12;stanford-crypto-pbkdf2;161;163;160;164;164;160;165;159;170;164 14:38:15 INFO - PROCESS | 3806 | |13;stanford-crypto-sha256-iterative;64;64;66;66;64;64;64;63;62;62 14:38:15 INFO - PROCESS | 3806 | __end_tp_report 14:38:15 INFO - PROCESS | 3806 | __start_cc_report 14:38:15 INFO - PROCESS | 3806 | _x_x_mozilla_cycle_collect,885 14:38:15 INFO - PROCESS | 3806 | __end_cc_report 14:38:15 INFO - PROCESS | 3806 | __startTimestamp1465853895139__endTimestamp 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | ------- Summary: start ------- 14:38:15 INFO - PROCESS | 3806 | Number of tests: 14 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:1.90 (1.7%) stddev-sans-first:1.94 14:38:15 INFO - PROCESS | 3806 | Values: 112.0 106.0 112.0 109.0 112.0 111.0 112.0 110.0 111.0 111.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:155.50 stddev:19.48 (12.5%) stddev-sans-first:20.35 14:38:15 INFO - PROCESS | 3806 | Values: 158.0 131.0 153.0 176.0 127.0 158.0 151.0 128.0 176.0 126.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:4.90 (3.0%) stddev-sans-first:5.17 14:38:15 INFO - PROCESS | 3806 | Values: 163.0 162.0 163.0 160.0 168.0 177.0 165.0 163.0 163.0 161.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:35.75 (47.7%) stddev-sans-first:37.36 14:38:15 INFO - PROCESS | 3806 | Values: 75.0 75.0 75.0 154.0 77.0 76.0 75.0 76.0 166.0 75.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.08 (33.0%) stddev-sans-first:29.12 14:38:15 INFO - PROCESS | 3806 | Values: 86.0 84.0 152.0 85.0 88.0 84.0 139.0 86.0 85.0 138.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:1.93 (1.7%) stddev-sans-first:2.03 14:38:15 INFO - PROCESS | 3806 | Values: 117.0 117.0 117.0 119.0 117.0 117.0 117.0 117.0 123.0 117.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 14:38:15 INFO - PROCESS | 3806 | Values: 147.0 147.0 147.0 146.0 150.0 148.0 147.0 147.0 148.0 146.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.48 (1.5%) stddev-sans-first:0.67 14:38:15 INFO - PROCESS | 3806 | Values: 100.0 97.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:1.27 14:38:15 INFO - PROCESS | 3806 | Values: 52.0 53.0 53.0 53.0 56.0 52.0 52.0 53.0 52.0 52.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.71 14:38:15 INFO - PROCESS | 3806 | Values: 64.0 63.0 61.0 62.0 62.0 63.0 62.0 61.0 62.0 62.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:82.50 stddev:9.41 (11.4%) stddev-sans-first:9.93 14:38:15 INFO - PROCESS | 3806 | Values: 83.0 81.0 81.0 81.0 85.0 82.0 82.0 87.0 112.0 84.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:132.50 stddev:4.97 (3.8%) stddev-sans-first:5.00 14:38:15 INFO - PROCESS | 3806 | Values: 135.0 130.0 122.0 138.0 130.0 132.0 129.0 133.0 133.0 123.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:164.00 stddev:3.23 (2.0%) stddev-sans-first:3.35 14:38:15 INFO - PROCESS | 3806 | Values: 161.0 163.0 160.0 164.0 164.0 160.0 165.0 159.0 170.0 164.0 14:38:15 INFO - PROCESS | 3806 | 14:38:15 INFO - PROCESS | 3806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 14:38:15 INFO - PROCESS | 3806 | Values: 64.0 64.0 66.0 66.0 64.0 64.0 64.0 63.0 62.0 62.0 14:38:15 INFO - PROCESS | 3806 | -------- Summary: end -------- 14:38:15 INFO - PROCESS | 3806 | 14:38:16 INFO - TEST-INFO | 3806: exit 0 14:38:16 INFO - TEST-OK | kraken | took 62721ms 14:38:16 INFO - SUITE-END | took 1176s 14:38:16 INFO - Completed test suite (00:19:36) 14:38:16 INFO - javascript benchmark 14:38:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7222.209592827864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.166734981555, 3118.9844050779743, 3119.12664453953, 3120.4539205639007, 3131.1076343242175, 5325.733713314334, 5336.786528538859, 5365.651232669874, 5427.565794736422, 5497.972510137453, 5264.710440925757, 5358.812441564546, 5365.087935051041, 5431.809886653968, 5444.537214336786, 4811.855644330667, 4824.17988941879, 4910.263460480921, 4974.228994505857, 4991.800327986876, 4841.7821198045995, 5044.4955504449445, 5090.465501122384, 5092.465291144432, 5099.184130539114, 4846.87882802931, 4871.14754917888, 4880.121578115938, 4901.754912254373, 4905.411350637911, 4923.507649235084, 4928.408590969071, 4937.654364194508, 4941.629377796644, 5006.424261209971, 4939.604831613462, 4940.2342636891335, 4954.3063971044085, 4966.602671786284, 4993.375828021497, 5190.169572868323, 5223.477652234784, 5269.473052694738, 5283.101872681654, 5352.759125839347, 5670.149477578355, 5688.800891968761, 5716.771329146829, 5759.913601295984, 5760.164776107483, 5608.971955140239, 5742.138679198112, 5747.712614369307, 5750.223719797816, 5755.165501002331, 5283.498067683564, 5300.443453437372, 5382.865428364283, 5423.810166644149, 5428.4300148484235, 5844.590878638454, 5875.41245875409, 5876.177335173079, 5890.998530249868, 5901.0558310670085, 5594.580406469531, 5608.0, 5665.1502274658305, 5691.630044047207, 5704.34400043992, 5710.114932185518, 5760.0783874579865, 5764.250647415809, 5771.163181338767, 5824.708764561839, 5545.861353466115, 5573.5819813514145, 5620.4660557247, 5717.0, 5735.283089613798, 5560.471755183251, 5647.774089036392, 5676.801311954062, 5686.09022556389, 5716.342620598684, 4172.749635021908, 4177.415161877339, 4201.768902710381, 4204.348326009474, 4232.894177645583, 3771.41543060826, 3784.280986612535, 3794.0894185395305, 3815.751976121543, 3817.9809100954317, 5335.33308336458, 5374.946250537523, 5452.972735136378, 5456.863578410572, 5543.695096769636, 5694.1458781183155, 5734.197212390269, 5738.540916726735, 5745.741441635137, 5764.7117644117625, 5433.782648694008, 5444.891102177934, 5471.945280547223, 5482.862928426821, 5493.533049690821, 4761.095391875532, 4812.326274321597, 4816.735079570587, 4845.854624361275, 4853.0, 5969.074793406942, 6037.516998640098, 6043.395660433922, 6056.878862422727, 6079.452849243501, 5806.390329015392, 5847.1229315603, 5857.121431785266, 5867.559933005127, 5872.442117998783, 5819.912701309569, 5984.16221728967, 6004.969975150271, 6054.727537260922, 6060.212172417558, 5685.971570142288, 5692.658440493584, 5774.2782152230975, 5774.94225057744, 5775.971120144372, 5831.241938547962, 5850.765969361348, 5861.6189947653265, 5875.854208429315, 5879.029960056543, 5498.972505137449, 5619.409961953936, 5646.0, 5673.716314184192, 5687.687177205128, 5522.0, 5600.355959064596, 5627.352854421794, 5640.774369025193, 5696.971515142398, 5594.216809646734, 5595.748191331319, 5610.691411972218, 5614.522765564972, 5615.438456154352, 5470.835874923759, 5588.916166257428, 5661.57538184646, 5703.08750599902, 5727.968965586235, 5585.748641311069, 5606.24315717373, 5608.551315894801, 5619.157126431068, 5623.718814059199], "value": 5297.29367867338, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.4224796327654, 620.5097972601643, 626.7493002798883, 643.6138317009795, 655.3381085104044, 36807.26385472289, 41156.0, 41200.0, 41252.58747412525, 41378.37932431016, 41894.371584426255, 41964.58035419645, 42209.78895105528, 42357.57642423575, 42620.0, 8721.912780872173, 8814.206721395074, 8836.46981181128, 8887.377883548153, 8919.197272245498, 8789.0, 8873.955630221872, 8879.644814207424, 8885.111488851095, 8885.333599979995, 8980.326475514363, 8995.0, 9017.0, 9018.188363047324, 9027.097290270985, 8932.374733768638, 8932.955335223314, 8945.59744811485, 8974.326925480582, 8974.641014359418, 8789.868151977726, 8835.690750823755, 8855.025947145808, 8884.111588841064, 8936.46381217129, 33685.494717579255, 39690.404643930364, 39986.80006599978, 40084.799576002224, 40105.39841902374, 3422.9144271393166, 3547.5388199533895, 3637.527121474218, 3745.887623371303, 3754.2866855297407, 30949.226269343446, 31232.843835780903, 32226.194345141324, 32331.19172020695, 32350.676493235, 4182.0, 4228.429162063113, 4247.936280955788, 4358.259095953664, 4432.069265454258, 316026.0, 319999.0, 320205.0, 320270.0, 320432.0, 35144.47283290753, 35175.648243517746, 35592.0, 35666.465003024976, 36141.27717445689, 37612.43581346282, 38004.0, 38043.80978095092, 38219.61780382161, 38299.80850095787, 15340.309686064154, 15378.3079761411, 15444.922775386276, 15523.0, 15597.766033509506, 13115.0, 13142.60572182836, 13147.934260328828, 13232.73534529304, 13276.203427794364, 8716.607752651145, 8741.606627701769, 8815.515146666867, 8860.379773415927, 8884.466931984101, 3445.448728203475, 3451.516787649731, 3452.8273586320583, 3492.5808902931813, 3493.8951831445097, 1015.1168483419325, 1079.7840431913648, 1083.9729006774735, 1089.3137323486312, 1177.1583317927723, 31546.526802097986, 31668.0, 31887.84056079705, 31909.840450797597, 32166.356672866412, 1143.1369316166408, 1150.5915400033034, 1151.3955173533961, 1190.6904204906787, 1194.4326444938586, 16673.749893751603, 16935.407260746062, 16958.40438277704, 17078.57303567396, 17106.315747369965, 508869.0, 509451.0, 510234.0, 512606.0, 512765.0, 57581.424185757605, 58874.411255886895, 58945.0, 59095.40904590985, 59145.11282330768, 1291.6770807298176, 1344.9731005379838, 1350.8851747601368, 1361.251311778518, 1386.057480912989, 30185.69814301829, 34191.82904085464, 34792.13019674528, 35065.47401788924, 37242.44136337903, 57481.71259143677, 58306.7084664574, 58485.0, 62076.0, 62656.686716566124, 533060.0, 545294.0, 545517.0, 546886.0, 548424.0, 46361.304580430646, 46583.0, 47488.0, 47637.52362476331, 48364.27453588128, 50615.0, 51486.0, 51890.74054629703, 51981.0, 52897.413077607736, 42390.78804605957, 44038.0, 44092.33861492016, 44153.55846441623, 44689.77655111704, 43189.568104318554, 43987.12025759531, 44150.33774493449, 44171.558284416744, 44675.0, 41979.7901010493, 42010.369844452965, 42126.0, 43143.78428107965, 43218.35172472353, 37358.62641373552, 37584.43623345597, 38034.239315214094, 38371.80814095912, 38755.0, 28415.43169136647, 28496.715032849406, 28626.284342891595, 28718.138455846358, 28921.710782891903], "value": 19346.72390080692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.1916369352062, 403.52182663543687, 404.629763766154, 409.3470913892341, 420.85270155445596, 13996.93001534991, 18978.52553686157, 18995.62008759824, 19795.40613781587, 19916.900415497938, 18057.187426565804, 18715.71926421105, 18730.15714292857, 18870.716939245922, 19188.808111918912, 5342.385625653061, 5530.644991976971, 5660.2075709400715, 5694.060480020812, 5788.363280039192, 5451.318585176853, 5654.717264136797, 5675.091985282355, 5720.656760594377, 5821.825345239649, 5786.421357864201, 5845.210896528978, 5865.765369385241, 5873.383294754032, 5912.556558258127, 5692.288463942007, 5704.828855134353, 5812.389699081599, 5822.155787410802, 5835.18307436957, 4978.576820970222, 5308.203769434577, 5381.973090134525, 5390.380106287788, 5596.188552659842, 13690.247036412993, 13898.722025559433, 14154.150750954976, 14270.0, 14348.497802576963, 2179.193698331612, 2246.3934737620916, 2392.3301475586863, 2552.438463538019, 2916.9207393264414, 10550.894491055145, 11451.88548114525, 13971.79042314366, 14762.0, 14873.330700118413, 1850.1489314915154, 1863.2857770850849, 1868.318063906678, 1903.6858918278467, 1937.5834195647863, 77496.22503774946, 78890.60554697247, 79503.0, 79569.60215198887, 80243.0, 9997.950010250048, 10279.743006424898, 10729.570817167381, 10768.138548916068, 10874.836877446845, 14455.349509272108, 14567.125972441687, 14570.562883113524, 14570.781438278435, 14579.489717859824, 7232.132144142632, 7450.143233528213, 7583.696652133964, 7743.574103424253, 7784.3772498200005, 7128.574285142992, 7148.142222933177, 7351.632418379059, 7361.6319184040585, 7629.351505122016, 4190.638042636156, 4249.660027197817, 4356.564343565618, 4365.563443655609, 4410.514843367227, 1837.7427160197583, 1876.7372567840514, 1881.9529511762316, 1914.4256722983328, 1971.3198946363482, 912.8311262416474, 961.5769061612868, 1004.1815920025156, 1086.0822604898847, 1090.7327704712395, 18961.43115706531, 19427.222911083398, 19433.805661943483, 19508.414747557596, 19573.706394404096, 995.3977843404781, 1006.9295149339622, 1052.5579256712047, 1071.3357718214602, 1119.692084676704, 10317.380957142444, 10824.4046577439, 11029.669109926715, 11180.04969577595, 11193.552257909756, 355555.0, 357870.0, 359083.0, 446491.0, 452344.0, 58589.121163182586, 75875.0, 84414.57792710997, 85576.0, 87664.0, 1009.0716540782498, 1023.4729114506035, 1047.7852040331866, 1048.9318194317345, 1052.2160990062453, 17550.648987020442, 17646.382491588938, 18052.368167114088, 18056.368027118988, 18387.0, 31204.843975779975, 41554.0, 43106.78446607747, 43765.0, 43910.78044609757, 59133.26933845368, 60384.396156037874, 61186.38813611807, 62042.37957620366, 62069.37930620817, 8279.54462504568, 8884.86672699923, 8922.643094276416, 8959.910400896168, 9046.366754327397, 13239.536616218771, 13672.52146174919, 13698.0, 13746.587602371545, 14013.929930350283, 11377.20359574855, 11562.0, 11883.524659013543, 11919.582814601446, 11988.76022479528, 11011.229213955266, 11838.467268972745, 11932.940335298268, 11936.403179841147, 12174.695632609255, 11277.887221128012, 11309.773804524028, 11621.360825154698, 11978.76042479163, 12052.939735301268, 8957.507337096522, 9000.36997410175, 9080.091990800867, 9276.907230927603, 9336.299777516577, 11327.263727857662, 11811.763764724485, 11859.762804743685, 12039.03687704964, 12168.939155304166], "value": 9030.01847882573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.2712257432572, 1479.35647993123, 1621.7486289625106, 1749.0555100245867, 1757.964840703186, 7953.403494737889, 8562.357823163264, 8591.0, 9138.360314777976, 9151.67969121081, 8684.261837743783, 8791.560421978907, 8974.102589741022, 8977.371583989123, 8985.95507022464, 2371.67982322386, 2391.964120538193, 2392.1149174805346, 2394.6408038794234, 2396.2212281008656, 2316.7104111986, 2332.9066837326486, 2354.2584086012935, 2358.0332063853825, 2365.396823809926, 2377.940551486209, 2378.8334816562847, 2384.201292566992, 2402.60357041088, 2403.230966090852, 2259.062489067035, 2269.795718385345, 2282.3038973113194, 2288.061894623205, 2340.754220806825, 2283.7259528856475, 2294.0823670531754, 2301.8158547316343, 2313.1672597864754, 2319.6636487709357, 8897.421667591585, 8904.8664270036, 8945.955270223607, 8992.505412202327, 9040.547972601344, 5242.60680448964, 5291.232771248147, 5412.512873841373, 5412.91880621791, 5413.485718856702, 3044.58898048765, 3214.3410600826774, 3217.420864244435, 3230.8223047732367, 3254.08885512057, 990.2127808392345, 1013.8175128476871, 1030.464158637512, 1038.361407734238, 1050.5692666006978, 11887.40562971848, 11964.222325548812, 12023.759524809455, 12098.334591597459, 12114.273143611323, 4586.220342541776, 4733.976330118397, 4736.4316282046375, 4744.620430365562, 4822.927656085161, 10172.491375431198, 10187.7453063674, 10194.592216311265, 10225.233107516966, 10306.793864122676, 5312.2297266896085, 5327.440618735054, 5343.70609616467, 5347.331583552056, 5349.063913815066, 4397.6042156206095, 4789.4971028042255, 4824.324594556765, 4976.925346119811, 5008.973160502088, 4049.6962727794944, 4107.414088882562, 4150.0, 4180.540140584533, 4207.852725154605, 1298.104308027458, 1306.6415120707024, 1326.2307861440343, 1328.2827273272517, 1332.6601716562216, 971.4851128901694, 988.7972965542046, 1004.8844382895915, 1014.8477728340808, 1028.92797504174, 5814.854628634318, 5876.059830427112, 5994.940050599525, 6064.06007068905, 6083.878322433615, 461.9145458090264, 474.0731869195714, 480.6011010860977, 484.8812041049965, 487.3007234618334, 4048.67610591152, 4068.8575899843363, 4117.114820313647, 4153.68847336451, 4169.791510424467, 10646.254762166574, 10895.237333386745, 10971.890281097247, 11017.0, 11035.779284414266, 10780.892191078146, 10808.945955270174, 10891.074258687942, 10924.071453926346, 10931.836022459669, 8156.2659360656635, 8232.518146733526, 8358.665653373919, 8369.539675317794, 8382.287505562095, 6106.267247930276, 6122.877542449215, 6193.81418557444, 6211.0, 6236.314005459305, 9997.650082247377, 10109.545070471699, 10112.949435252776, 10131.949340253252, 10250.436226007641, 10058.798824023625, 10300.793984120126, 10419.218558608287, 10470.476476176313, 10557.683269501927, 7115.181754098138, 7688.0, 7925.405594580314, 7959.124496305286, 8053.23494268067, 8875.644974201217, 8901.821963560564, 8907.554622268732, 8949.776255593662, 8958.955205224192, 7570.772876813704, 7682.347000505019, 7770.689172433265, 7788.805279868048, 8132.024157101186, 7627.733029343946, 7629.38964882797, 7740.574268415291, 7869.173736757787, 7893.97378340812, 7101.218865924848, 7125.893111603226, 7190.96404517974, 7191.820204494929, 7199.3520583147765, 5064.569511591556, 5116.334876466036, 5285.920711189258, 5301.973490132525, 5397.703126327932, 5384.0, 5486.341639003345, 5559.471850174227, 5572.052751032254, 5662.207290979184], "value": 4600.563404663713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.14625631511495, 344.60886893376016, 347.0681220921824, 353.98761043363487, 355.55733112275203, 5483.122700367942, 5503.174523821429, 5679.642948176507, 5699.971500142498, 5700.971495142524, 5489.972550137254, 5504.559635229182, 5510.393856675772, 5529.3364796224405, 5552.5280351170095, 4282.8715138545895, 4304.503388034947, 4312.460942382202, 4313.0, 4325.199838029975, 4159.875203743893, 4312.0, 4330.437043184382, 4335.43639326887, 4337.587929146726, 4255.361695745632, 4263.168682106991, 4267.274563324227, 4281.892952676177, 4301.505326887401, 4306.7631280279575, 4317.76252306123, 4326.134773045372, 4329.631981281564, 4342.218400687875, 3640.5801737322467, 3759.2293579816346, 3797.3671321331817, 3814.5041144651295, 3818.732688711791, 5395.892082158335, 5424.647397919122, 5440.727963601804, 5465.426130256305, 5466.753996070186, 4883.19427294496, 4905.754712264408, 4914.729689867056, 4922.384701912261, 4932.728699921503, 5553.555715542747, 5747.62640428375, 5793.478586927196, 5797.420257974211, 5815.098659707752, 4051.9392209116886, 4087.5299340575916, 4087.589781525369, 4098.610631989956, 4105.753654780723, 5987.580869339148, 6028.6985650717725, 6037.396260373971, 6039.969800150971, 6071.848203794852, 4137.358709400048, 4179.477565304337, 4195.202911446876, 4202.138561594927, 4243.915121697611, 4288.09949910516, 4313.503947046067, 4317.697761156752, 4318.438602981592, 4335.024619460659, 4937.259411088366, 4946.925796112989, 4947.925781113287, 4957.826476073392, 4996.200607902718, 5228.4510126436935, 5810.099434587646, 5890.617109887844, 5920.940790592125, 5952.821415357546, 1489.7392956232616, 1496.4537943650707, 1502.9624259393383, 1503.999840106339, 1507.2765072765135, 955.6559638530124, 968.1818863060703, 980.6910823090703, 981.3621146254991, 982.7051884434641, 5021.297018417425, 5037.899242015139, 5056.216286475602, 5095.668781529189, 5098.311727916684, 5327.254184414185, 5332.466753324714, 5334.679919204783, 5341.118715411913, 5395.298611180521, 5011.423686276052, 5070.847874563695, 5087.720175390315, 5292.676830792302, 5776.913346299725, 3177.9841100794347, 3191.69678880506, 3210.229544909205, 3217.951730724041, 3219.036387803438, 6128.0279064653605, 6243.500519958392, 6245.812625621239, 6260.373962603703, 6286.905696414466, 6116.327204007555, 6139.2325959255095, 6139.386061393825, 6141.84645383869, 6142.662153581596, 6125.387461253839, 6212.81361559154, 6235.127082208403, 6252.499800015988, 6308.810735677937, 5840.269966254218, 5947.226860508106, 6012.8797424052145, 6023.728932198149, 6031.788887388921, 5836.912446313394, 5894.6757928314355, 5913.881722365614, 5951.256092988377, 5992.460678538952, 5994.760209591567, 6172.22847144107, 6203.8833010056815, 6218.098375735402, 6235.594686345373, 4254.149170166041, 4262.891648171436, 4273.358996150478, 4286.571342865688, 4292.91414171721, 5761.279840019997, 5822.4759771619065, 6057.091436284416, 6074.878502429839, 6079.3008803988105, 5798.217240672455, 5802.47777700009, 5835.124731290341, 5856.736446859816, 5865.178874957424, 5818.563607729353, 5823.242978412779, 5838.824835254949, 5859.355470898113, 5910.4089591042275, 5531.137536772235, 5702.857428564153, 5708.429157084258, 5756.1941328214925, 5763.394843541368, 5816.621919575214, 5817.360090390139, 5859.945209862266, 5898.4101589840675, 5903.203067585821, 5510.732531517693, 5670.631408958405, 5706.3152421709665, 5818.6217895836635, 5832.708364581838], "value": 4407.007165128061, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.2033762860854, 767.7428061599361, 788.5150632361098, 790.1854809598923, 832.5004997001796, 15103.924480377596, 16023.11872846993, 16355.264013119408, 16361.509154725347, 16389.754153687703, 14911.552653420387, 15016.324265408055, 15079.924600376982, 15108.924455377735, 15190.620234494143, 680.4148432348202, 809.9878501822462, 827.9420440569163, 829.0176141272581, 829.0465964141225, 796.9203079692013, 814.8859159717645, 816.8529664660359, 818.979525511861, 821.765796747927, 852.3564708644965, 869.2003356911625, 870.3559366069095, 870.7605408512678, 870.9085546017672, 846.1031306814765, 854.2567965869671, 855.1576696953526, 856.755824589992, 856.7686724584389, 622.4024936061387, 628.5160426471637, 628.6008384675719, 629.5247088448192, 631.1101347100566, 14551.126932383984, 14584.343704533321, 14643.92678036603, 14647.853521464756, 14735.705285894222, 15327.080375177413, 15335.693286134216, 15345.693086138326, 15470.381184752596, 15488.767668484981, 11575.47910344028, 11892.079207920791, 11898.940505297505, 12183.0, 12326.0, 3758.285925674113, 3788.204477059821, 3799.44251078095, 3813.599572044951, 3957.386605076189, 67235.66382168057, 70720.29279707189, 71818.2818171822, 73116.6344168281, 74043.25956740418, 11622.476988535536, 11875.703107422383, 12125.696857578454, 12181.208221465753, 12323.69190770238, 22954.19660311881, 23020.65469017966, 23194.0, 23326.416839578807, 23743.287701368987, 8816.294696424271, 8989.730308090768, 9074.909250907538, 9133.588988495534, 9394.107559781809, 4793.400824896888, 4837.22604383304, 4884.462709101996, 4888.877778055506, 4957.008598280287, 3570.321638888603, 3683.060819491013, 3694.815259237081, 3712.7029837612927, 3714.7213958953184, 656.7865443730807, 658.6904155047121, 671.2951401028997, 674.6694119881321, 681.9079424277759, 636.5512313818747, 640.9006603976391, 661.4311691944923, 683.733343995842, 698.5005720909573, 9751.561179746786, 9884.24398728493, 9911.256655750847, 10330.328528645614, 10560.366378017343, 612.8621060261495, 678.1827897383641, 678.2369833936821, 693.9618320992292, 712.4727701500956, 4672.556107169813, 4909.386326709161, 4930.112579735682, 4955.821166880618, 5011.09800235961, 119421.40289298497, 120404.0, 120826.39586802185, 124909.37545312397, 126071.36964315119, 103174.48412757888, 104303.4784826071, 106033.0, 106380.46809765902, 107485.46257268664, 55766.72116639391, 57118.42881571131, 67248.66375668091, 80787.0, 87157.99999999873, 9397.252481299578, 9406.905930940877, 9465.621375144918, 9565.882252994614, 9614.375065620712, 50411.74794126006, 51134.23298650449, 51898.74050629874, 53444.19833702575, 53887.0, 50119.0, 73698.0, 74517.0, 75330.0, 75345.62327188549, 12397.194182378116, 12907.935460322638, 12924.870751292367, 12933.482660693468, 13357.599272021855, 13223.603291901258, 13590.524331648345, 14061.36723847409, 14169.787453188417, 14181.432742690176, 12673.93663031716, 12748.171368860994, 12998.480060797841, 13010.154339967872, 13025.934870325587, 12488.500459981498, 12495.375231238584, 12892.806607901077, 13258.204507729568, 13839.515616953358, 13181.40683669218, 13345.332733363099, 13396.665083372603, 13426.261555614536, 13521.526746563823, 10728.517216725422, 10838.729031774268, 10909.83635245456, 10984.450777461256, 11484.94257528707, 10769.138468922623, 10861.837072444077, 11185.398902344363, 11201.66395008151, 11269.66191014271], "value": 7562.641902502593, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 109.0, 112.0, 111.0, 112.0, 110.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 153.0, 176.0, 127.0, 158.0, 151.0, 128.0, 176.0, 126.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 160.0, 168.0, 177.0, 165.0, 163.0, 163.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 154.0, 77.0, 76.0, 75.0, 76.0, 166.0, 75.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 152.0, 85.0, 88.0, 84.0, 139.0, 86.0, 85.0, 138.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 123.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 150.0, 148.0, 147.0, 147.0, 148.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 56.0, 52.0, 52.0, 53.0, 52.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 61.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 81.0, 85.0, 82.0, 82.0, 87.0, 112.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 130.0, 122.0, 138.0, 130.0, 132.0, 129.0, 133.0, 133.0, 123.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 164.0, 164.0, 160.0, 165.0, 159.0, 170.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 66.0, 64.0, 64.0, 64.0, 63.0, 62.0, 62.0], "value": 63.9, "unit": "score"}]}]} 14:38:16 INFO - Return code: 0 14:38:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:38:16 ERROR - # TBPL SUCCESS # 14:38:16 INFO - Running post-action listener: _resource_record_post_action 14:38:16 INFO - ##### 14:38:16 INFO - ##### Finished run-tests step (success) 14:38:16 INFO - ##### 14:38:16 INFO - Running post-run listener: _resource_record_post_run 14:38:16 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 7786496; Write bytes: 390172672; Read time: 1792; Write time: 410924 14:38:16 INFO - TinderboxPrint: CPU usage
13.5% 14:38:16 INFO - TinderboxPrint: I/O read bytes / time
7,786,496 / 1,792 14:38:16 INFO - TinderboxPrint: I/O write bytes / time
390,172,672 / 410,924 14:38:16 INFO - TinderboxPrint: CPU idle
8,246.6 (86.5%) 14:38:16 INFO - TinderboxPrint: CPU user
1,225.7 (12.9%) 14:38:16 INFO - TinderboxPrint: Swap in / out
0 / 0 14:38:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 102281216; Read time: 0; Write time: 129156 14:38:16 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6025216; Write bytes: 228392960; Read time: 1552; Write time: 244992 14:38:17 INFO - Running post-run listener: _upload_blobber_files 14:38:17 INFO - Blob upload gear active. 14:38:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:17 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 14:38:17 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:38:17 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:38:17 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:38:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:18 INFO - (blobuploader) - INFO - Done attempting. 14:38:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:23 INFO - (blobuploader) - INFO - Done attempting. 14:38:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:38:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:38:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:23 INFO - (blobuploader) - INFO - Done attempting. 14:38:23 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:23 INFO - Return code: 0 14:38:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecffda5b32e1447b3bf97b22d645b75ba750d4e0e2d08d4c7592722033361ef3344c19723d6675934dae7c8a47cf42e22eaee18c06d9f7621b3f92752127c4db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a04a99068c9802b156d4bca7e2ed808f45e1d5cb84a1ed341219be3416ce438e862c9c6b8c2152986121bbef3e86d196cf40703ad38fa27beb679e52317a374e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763350fc6e12b0f5c58f48861004eb1e1b32203039078cb9b2fcc54d9d9cd2bf47089e58253a031f22840722d95274e45ec0bff631642de4da0f7cb86769d90b"} 14:38:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:23 INFO - Contents: 14:38:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ecffda5b32e1447b3bf97b22d645b75ba750d4e0e2d08d4c7592722033361ef3344c19723d6675934dae7c8a47cf42e22eaee18c06d9f7621b3f92752127c4db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a04a99068c9802b156d4bca7e2ed808f45e1d5cb84a1ed341219be3416ce438e862c9c6b8c2152986121bbef3e86d196cf40703ad38fa27beb679e52317a374e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763350fc6e12b0f5c58f48861004eb1e1b32203039078cb9b2fcc54d9d9cd2bf47089e58253a031f22840722d95274e45ec0bff631642de4da0f7cb86769d90b"} 14:38:23 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:23 INFO - Copying logs to upload dir... 14:38:23 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.385270 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-13 14:38:23.958730) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 14:38:23.962929) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461 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/Fx-Team/sha512/ecffda5b32e1447b3bf97b22d645b75ba750d4e0e2d08d4c7592722033361ef3344c19723d6675934dae7c8a47cf42e22eaee18c06d9f7621b3f92752127c4db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a04a99068c9802b156d4bca7e2ed808f45e1d5cb84a1ed341219be3416ce438e862c9c6b8c2152986121bbef3e86d196cf40703ad38fa27beb679e52317a374e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763350fc6e12b0f5c58f48861004eb1e1b32203039078cb9b2fcc54d9d9cd2bf47089e58253a031f22840722d95274e45ec0bff631642de4da0f7cb86769d90b"} build_url:https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/e7bM722-SJaoh08Ou2bS-Q/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/Fx-Team/sha512/ecffda5b32e1447b3bf97b22d645b75ba750d4e0e2d08d4c7592722033361ef3344c19723d6675934dae7c8a47cf42e22eaee18c06d9f7621b3f92752127c4db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a04a99068c9802b156d4bca7e2ed808f45e1d5cb84a1ed341219be3416ce438e862c9c6b8c2152986121bbef3e86d196cf40703ad38fa27beb679e52317a374e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763350fc6e12b0f5c58f48861004eb1e1b32203039078cb9b2fcc54d9d9cd2bf47089e58253a031f22840722d95274e45ec0bff631642de4da0f7cb86769d90b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 14:38:23.990551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:38:23.990878) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465852055.628954-1873916461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 14:38:24.070245) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 14:38:24.073587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 14:38:24.073879) ========= ========= Total master_lag: 0.20 =========