builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1466100383.61 results: success (0) buildid: 20160616103225 builduid: a0993190f640487b95db464b91a8908f revision: 942a42c22de790ca091f1e329250ef11217636bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:23.612912) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:23.613437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:23.613760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:23.645042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:23.645388) ========= 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=232498196343f89f466a4a9a000001c8-1466099607.43586-44492617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 11:06:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-06-16 11:06:24 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084776 ========= master_lag: 0.31 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.042390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.042761) ========= 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=232498196343f89f466a4a9a000001c8-1466099607.43586-44492617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020864 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.101538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.101950) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 942a42c22de790ca091f1e329250ef11217636bc --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 942a42c22de790ca091f1e329250ef11217636bc --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=232498196343f89f466a4a9a000001c8-1466099607.43586-44492617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 11:06:24,549 truncating revision to first 12 chars 2016-06-16 11:06:24,549 Setting DEBUG logging. 2016-06-16 11:06:24,549 attempt 1/10 2016-06-16 11:06:24,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/942a42c22de7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 11:06:24,854 unpacking tar archive at: fx-team-942a42c22de7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.783404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.783795) ========= script_repo_revision: 942a42c22de790ca091f1e329250ef11217636bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.787065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.787384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 11:06:24.799127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-16 11:06:24.799573) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=232498196343f89f466a4a9a000001c8-1466099607.43586-44492617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:25 INFO - MultiFileLogger online at 20160616 11:06:25 in /builds/slave/test 11:06:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:25 INFO - {'append_to_log': False, 11:06:25 INFO - 'base_work_dir': '/builds/slave/test', 11:06:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:25 INFO - 'branch': 'Fx-Team-Non-PGO', 11:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:25 INFO - 'config_files': ('talos/linux_config.py',), 11:06:25 INFO - 'default_actions': ('clobber', 11:06:25 INFO - 'read-buildbot-config', 11:06:25 INFO - 'download-and-extract', 11:06:25 INFO - 'populate-webroot', 11:06:25 INFO - 'create-virtualenv', 11:06:25 INFO - 'install', 11:06:25 INFO - 'run-tests'), 11:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:25 INFO - 'download_minidump_stackwalk': True, 11:06:25 INFO - 'download_symbols': 'ondemand', 11:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:25 INFO - 'installer_path': 'installer.exe', 11:06:25 INFO - 'log_level': 'info', 11:06:25 INFO - 'log_name': 'talos', 11:06:25 INFO - 'log_to_console': True, 11:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:25 INFO - 'opt_config_files': (), 11:06:25 INFO - 'pip_index': False, 11:06:25 INFO - 'sps_profile': False, 11:06:25 INFO - 'sps_profile_interval': 0, 11:06:25 INFO - 'suite': 'dromaeojs', 11:06:25 INFO - 'system_bits': '32', 11:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:25 INFO - 'title': 'talos-linux64-ix-025', 11:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:25 INFO - 'use_talos_json': True, 11:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:25 INFO - 'work_dir': 'build'} 11:06:25 INFO - ##### 11:06:25 INFO - ##### Running clobber step. 11:06:25 INFO - ##### 11:06:25 INFO - Running pre-action listener: _resource_record_pre_action 11:06:25 INFO - Running main action method: clobber 11:06:25 INFO - rmtree: /builds/slave/test/build 11:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:25 INFO - Running post-action listener: _resource_record_post_action 11:06:25 INFO - ##### 11:06:25 INFO - ##### Finished clobber step (success) 11:06:25 INFO - ##### 11:06:25 INFO - ##### 11:06:25 INFO - ##### Running read-buildbot-config step. 11:06:25 INFO - ##### 11:06:25 INFO - Running pre-action listener: _resource_record_pre_action 11:06:25 INFO - Running main action method: read_buildbot_config 11:06:25 INFO - Using buildbot properties: 11:06:25 INFO - { 11:06:25 INFO - "project": "", 11:06:25 INFO - "product": "firefox", 11:06:25 INFO - "script_repo_revision": "production", 11:06:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:06:25 INFO - "repository": "", 11:06:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:06:25 INFO - "buildid": "20160616103225", 11:06:25 INFO - "pgo_build": "False", 11:06:25 INFO - "basedir": "/builds/slave/test", 11:06:25 INFO - "buildnumber": 1870, 11:06:25 INFO - "slavename": "talos-linux64-ix-025", 11:06:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:06:25 INFO - "platform": "ubuntu64_hw", 11:06:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:06:25 INFO - "branch": "fx-team", 11:06:25 INFO - "repo_path": "integration/fx-team", 11:06:25 INFO - "revision": "942a42c22de790ca091f1e329250ef11217636bc", 11:06:25 INFO - "stage_platform": "linux64", 11:06:25 INFO - "builduid": "a0993190f640487b95db464b91a8908f", 11:06:25 INFO - "slavebuilddir": "test" 11:06:25 INFO - } 11:06:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:06:25 INFO - Running post-action listener: _resource_record_post_action 11:06:25 INFO - ##### 11:06:25 INFO - ##### Finished read-buildbot-config step (success) 11:06:25 INFO - ##### 11:06:25 INFO - ##### 11:06:25 INFO - ##### Running download-and-extract step. 11:06:25 INFO - ##### 11:06:25 INFO - Running pre-action listener: _resource_record_pre_action 11:06:25 INFO - Running main action method: download_and_extract 11:06:25 INFO - mkdir: /builds/slave/test/build/tests 11:06:25 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')]} 11:06:25 INFO - https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:30 INFO - Downloaded 1361 bytes. 11:06:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:06:30 INFO - Using the following test package requirements: 11:06:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:06:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:06:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'jsshell-linux-x86_64.zip'], 11:06:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:06:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:06:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:06:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:06:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:06:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:06:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:06:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:30 INFO - https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:31 INFO - Downloaded 22654315 bytes. 11:06:31 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'] 11:06:31 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 11:06:32 INFO - Return code: 0 11:06:32 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 11:06:32 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')]} 11:06:32 INFO - https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:34 INFO - Downloaded 22654315 bytes. 11:06:34 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'] 11:06:34 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 11:06:36 INFO - Return code: 0 11:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:36 INFO - https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:38 INFO - Downloaded 14405384 bytes. 11:06:38 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'] 11:06:38 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 11:06:39 INFO - Return code: 0 11:06:39 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')]} 11:06:39 INFO - https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbM7MAikRzGHj4SfwTbhFg/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 11:06:44 INFO - Downloaded 55446618 bytes. 11:06:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:06:44 INFO - mkdir: /builds/slave/test/properties 11:06:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:06:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:06:44 INFO - Contents: 11:06:44 INFO - build_url:https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:06:45 INFO - Running post-action listener: _resource_record_post_action 11:06:45 INFO - Running post-action listener: set_extra_try_arguments 11:06:45 INFO - ##### 11:06:45 INFO - ##### Finished download-and-extract step (success) 11:06:45 INFO - ##### 11:06:45 INFO - ##### 11:06:45 INFO - ##### Running populate-webroot step. 11:06:45 INFO - ##### 11:06:45 INFO - Running pre-action listener: _resource_record_pre_action 11:06:45 INFO - Running main action method: populate_webroot 11:06:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:06:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:06:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:06:45 INFO - '--tppagecycles', 11:06:45 INFO - '7'], 11:06:45 INFO - 'tests': ['tsvgm']}}, 11:06:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:06:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:06:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:06:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:06:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:06:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['damp', 'tps']}, 11:06:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'tests': ['damp', 'tps']}, 11:06:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['dromaeo_dom']}, 11:06:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:06:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['basic_compositor_video']}, 11:06:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:06:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['a11yr', 11:06:45 INFO - 'ts_paint', 11:06:45 INFO - 'tpaint', 11:06:45 INFO - 'sessionrestore', 11:06:45 INFO - 'sessionrestore_no_auto_restore', 11:06:45 INFO - 'tabpaint']}, 11:06:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:06:45 INFO - 'ts_paint', 11:06:45 INFO - 'tpaint', 11:06:45 INFO - 'sessionrestore', 11:06:45 INFO - 'sessionrestore_no_auto_restore', 11:06:45 INFO - 'tabpaint']}, 11:06:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:06:45 INFO - 'ts_paint', 11:06:45 INFO - 'tpaint', 11:06:45 INFO - 'sessionrestore', 11:06:45 INFO - 'sessionrestore_no_auto_restore', 11:06:45 INFO - 'tabpaint']}, 11:06:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:06:45 INFO - 'ts_paint', 11:06:45 INFO - 'tpaint', 11:06:45 INFO - 'sessionrestore', 11:06:45 INFO - 'sessionrestore_no_auto_restore', 11:06:45 INFO - 'tabpaint']}, 11:06:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['a11yr', 11:06:45 INFO - 'ts_paint', 11:06:45 INFO - 'tpaint', 11:06:45 INFO - 'sessionrestore', 11:06:45 INFO - 'sessionrestore_no_auto_restore', 11:06:45 INFO - 'tabpaint']}, 11:06:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['a11yr', 11:06:45 INFO - 'ts_paint', 11:06:45 INFO - 'tpaint', 11:06:45 INFO - 'sessionrestore', 11:06:45 INFO - 'sessionrestore_no_auto_restore', 11:06:45 INFO - 'tabpaint']}, 11:06:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['tsvgx', 11:06:45 INFO - 'tsvgr_opacity', 11:06:45 INFO - 'tart', 11:06:45 INFO - 'tscrollx', 11:06:45 INFO - 'cart']}, 11:06:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:06:45 INFO - 'tsvgr_opacity', 11:06:45 INFO - 'tart', 11:06:45 INFO - 'tscrollx', 11:06:45 INFO - 'cart']}, 11:06:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'talos_options': ['--disable-e10s'], 11:06:45 INFO - 'tests': ['tp5o']}, 11:06:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'tests': ['tp5o']}, 11:06:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'talos_options': ['--disable-e10s', 11:06:45 INFO - '--xperf_path', 11:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:45 INFO - 'tests': ['tp5n']}, 11:06:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:06:45 INFO - 'talos_options': ['--xperf_path', 11:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:06:45 INFO - 'tests': ['tp5n']}}, 11:06:45 INFO - 'talos.zip': {'path': '', 11:06:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:06:45 INFO - Running post-action listener: _resource_record_post_action 11:06:45 INFO - ##### 11:06:45 INFO - ##### Finished populate-webroot step (success) 11:06:45 INFO - ##### 11:06:45 INFO - ##### 11:06:45 INFO - ##### Running create-virtualenv step. 11:06:45 INFO - ##### 11:06:45 INFO - Running pre-action listener: _resource_record_pre_action 11:06:45 INFO - Running main action method: create_virtualenv 11:06:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:06:45 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 11:06:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:06:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:06:45 INFO - Using real prefix '/usr' 11:06:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:06:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:06:47 INFO - Installing pip.................done. 11:06:47 INFO - Return code: 0 11:06:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:47 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:06:47 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 11:06:47 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 11:06:47 INFO - Using env: {'DISPLAY': ':0', 11:06:47 INFO - 'HOME': '/home/cltbld', 11:06:47 INFO - 'LANG': 'en_US.UTF-8', 11:06:47 INFO - 'LANGUAGE': 'en_US:en', 11:06:47 INFO - 'LOGNAME': 'cltbld', 11:06:47 INFO - 'MAIL': '/var/mail/cltbld', 11:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:47 INFO - 'MOZ_NO_REMOTE': '1', 11:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:47 INFO - 'NO_EM_RESTART': '1', 11:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:47 INFO - 'PWD': '/builds/slave/test', 11:06:47 INFO - 'SHELL': '/bin/bash', 11:06:47 INFO - 'SHLVL': '1', 11:06:47 INFO - 'TERM': 'linux', 11:06:47 INFO - 'TMOUT': '86400', 11:06:47 INFO - 'USER': 'cltbld', 11:06:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:47 INFO - '_': '/tools/buildbot/bin/python'} 11:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:48 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 11:06:48 INFO - Cleaning up... 11:06:48 INFO - Return code: 0 11:06:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:06:48 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')]} 11:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:48 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')]} 11:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:48 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:06:48 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 11:06:48 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 11:06:48 INFO - Using env: {'DISPLAY': ':0', 11:06:48 INFO - 'HOME': '/home/cltbld', 11:06:48 INFO - 'LANG': 'en_US.UTF-8', 11:06:48 INFO - 'LANGUAGE': 'en_US:en', 11:06:48 INFO - 'LOGNAME': 'cltbld', 11:06:48 INFO - 'MAIL': '/var/mail/cltbld', 11:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:48 INFO - 'MOZ_NO_REMOTE': '1', 11:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:48 INFO - 'NO_EM_RESTART': '1', 11:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:48 INFO - 'PWD': '/builds/slave/test', 11:06:48 INFO - 'SHELL': '/bin/bash', 11:06:48 INFO - 'SHLVL': '1', 11:06:48 INFO - 'TERM': 'linux', 11:06:48 INFO - 'TMOUT': '86400', 11:06:48 INFO - 'USER': 'cltbld', 11:06:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:48 INFO - '_': '/tools/buildbot/bin/python'} 11:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:48 INFO - Downloading/unpacking psutil>=3.1.1 11:06:48 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 11:06:48 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 11:06:48 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 11:06:48 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 11:06:48 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 11:06:48 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 11:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:50 INFO - Installing collected packages: psutil 11:06:50 INFO - Running setup.py install for psutil 11:06:50 INFO - building 'psutil._psutil_linux' extension 11:06:50 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 11:06:50 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 11:06:50 INFO - building 'psutil._psutil_posix' extension 11:06:50 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 11:06:50 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 11:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:06:50 INFO - Successfully installed psutil 11:06:50 INFO - Cleaning up... 11:06:50 INFO - Return code: 0 11:06:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:06:50 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')]} 11:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:50 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')]} 11:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:50 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:06:50 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 11:06:50 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 11:06:50 INFO - Using env: {'DISPLAY': ':0', 11:06:50 INFO - 'HOME': '/home/cltbld', 11:06:50 INFO - 'LANG': 'en_US.UTF-8', 11:06:50 INFO - 'LANGUAGE': 'en_US:en', 11:06:50 INFO - 'LOGNAME': 'cltbld', 11:06:50 INFO - 'MAIL': '/var/mail/cltbld', 11:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:50 INFO - 'MOZ_NO_REMOTE': '1', 11:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:50 INFO - 'NO_EM_RESTART': '1', 11:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:50 INFO - 'PWD': '/builds/slave/test', 11:06:50 INFO - 'SHELL': '/bin/bash', 11:06:50 INFO - 'SHLVL': '1', 11:06:50 INFO - 'TERM': 'linux', 11:06:50 INFO - 'TMOUT': '86400', 11:06:50 INFO - 'USER': 'cltbld', 11:06:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:50 INFO - '_': '/tools/buildbot/bin/python'} 11:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:53 INFO - Installing collected packages: mozsystemmonitor 11:06:53 INFO - Running setup.py install for mozsystemmonitor 11:06:53 INFO - Successfully installed mozsystemmonitor 11:06:53 INFO - Cleaning up... 11:06:53 INFO - Return code: 0 11:06:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:53 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')]} 11:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:53 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')]} 11:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:53 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:06:53 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 11:06:53 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 11:06:53 INFO - Using env: {'DISPLAY': ':0', 11:06:53 INFO - 'HOME': '/home/cltbld', 11:06:53 INFO - 'LANG': 'en_US.UTF-8', 11:06:53 INFO - 'LANGUAGE': 'en_US:en', 11:06:53 INFO - 'LOGNAME': 'cltbld', 11:06:53 INFO - 'MAIL': '/var/mail/cltbld', 11:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:53 INFO - 'MOZ_NO_REMOTE': '1', 11:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:53 INFO - 'NO_EM_RESTART': '1', 11:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:53 INFO - 'PWD': '/builds/slave/test', 11:06:53 INFO - 'SHELL': '/bin/bash', 11:06:53 INFO - 'SHLVL': '1', 11:06:53 INFO - 'TERM': 'linux', 11:06:53 INFO - 'TMOUT': '86400', 11:06:53 INFO - 'USER': 'cltbld', 11:06:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:53 INFO - '_': '/tools/buildbot/bin/python'} 11:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:53 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:53 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 11:06:53 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 11:06:53 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 11:06:53 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 11:06:53 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 11:06:53 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 11:06:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06:55 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 11:06:55 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 11:06:55 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 11:06:55 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 11:06:55 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 11:06:55 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 11:06:55 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:55 INFO - warning: no files found matching '*.txt' 11:06:55 INFO - no previously-included directories found matching 'build' 11:06:55 INFO - no previously-included directories found matching 'dist' 11:06:55 INFO - no previously-included directories found matching '.git*' 11:06:55 INFO - Installing collected packages: jsonschema, functools32 11:06:55 INFO - Running setup.py install for functools32 11:06:55 INFO - warning: no files found matching '*.txt' 11:06:55 INFO - no previously-included directories found matching 'build' 11:06:55 INFO - no previously-included directories found matching 'dist' 11:06:55 INFO - no previously-included directories found matching '.git*' 11:06:55 INFO - Successfully installed jsonschema functools32 11:06:55 INFO - Cleaning up... 11:06:55 INFO - Return code: 0 11:06:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:55 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:06:55 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 11:06:55 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 11:06:55 INFO - Using env: {'DISPLAY': ':0', 11:06:55 INFO - 'HOME': '/home/cltbld', 11:06:55 INFO - 'LANG': 'en_US.UTF-8', 11:06:55 INFO - 'LANGUAGE': 'en_US:en', 11:06:55 INFO - 'LOGNAME': 'cltbld', 11:06:55 INFO - 'MAIL': '/var/mail/cltbld', 11:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:55 INFO - 'MOZ_NO_REMOTE': '1', 11:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:55 INFO - 'NO_EM_RESTART': '1', 11:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:55 INFO - 'PWD': '/builds/slave/test', 11:06:55 INFO - 'SHELL': '/bin/bash', 11:06:55 INFO - 'SHLVL': '1', 11:06:55 INFO - 'TERM': 'linux', 11:06:55 INFO - 'TMOUT': '86400', 11:06:55 INFO - 'USER': 'cltbld', 11:06:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:55 INFO - '_': '/tools/buildbot/bin/python'} 11:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:55 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 11:06:55 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 11:06:55 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 11:06:55 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 11:06:55 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 11:06:55 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 11:06:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06:57 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 11:06:57 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 11:06:57 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 11:06:57 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 11:06:57 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 11:06:57 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 11:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06:58 INFO - Downloading docopt-0.6.1.tar.gz 11:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:58 INFO - Running setup.py install for blobuploader 11:06:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:58 INFO - Running setup.py install for requests 11:06:59 INFO - Running setup.py install for docopt 11:06:59 INFO - Successfully installed blobuploader requests docopt 11:06:59 INFO - Cleaning up... 11:06:59 INFO - Return code: 0 11:06:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06:59 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')]} 11:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:59 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')]} 11:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:59 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:06:59 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 11:06:59 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 11:06:59 INFO - Using env: {'DISPLAY': ':0', 11:06:59 INFO - 'HOME': '/home/cltbld', 11:06:59 INFO - 'LANG': 'en_US.UTF-8', 11:06:59 INFO - 'LANGUAGE': 'en_US:en', 11:06:59 INFO - 'LOGNAME': 'cltbld', 11:06:59 INFO - 'MAIL': '/var/mail/cltbld', 11:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:59 INFO - 'MOZ_NO_REMOTE': '1', 11:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:59 INFO - 'NO_EM_RESTART': '1', 11:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:59 INFO - 'PWD': '/builds/slave/test', 11:06:59 INFO - 'SHELL': '/bin/bash', 11:06:59 INFO - 'SHLVL': '1', 11:06:59 INFO - 'TERM': 'linux', 11:06:59 INFO - 'TMOUT': '86400', 11:06:59 INFO - 'USER': 'cltbld', 11:06:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:59 INFO - '_': '/tools/buildbot/bin/python'} 11:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:59 INFO - Running setup.py (path:/tmp/pip-RhsnWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:59 INFO - Running setup.py (path:/tmp/pip-Z_L8Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:59 INFO - Running setup.py (path:/tmp/pip-F3Tyj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:59 INFO - Running setup.py (path:/tmp/pip-MBhfRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:59 INFO - Running setup.py (path:/tmp/pip-ZNkX43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:59 INFO - Running setup.py (path:/tmp/pip-XNPb2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:59 INFO - Running setup.py (path:/tmp/pip-rXwJwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:59 INFO - Running setup.py (path:/tmp/pip-2uPWuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:00 INFO - Running setup.py (path:/tmp/pip-Dotwjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:00 INFO - Running setup.py (path:/tmp/pip-2LxOvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:00 INFO - Running setup.py (path:/tmp/pip-yFyc8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:00 INFO - Running setup.py (path:/tmp/pip-4etX2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:00 INFO - Running setup.py (path:/tmp/pip-tmG4Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:00 INFO - Running setup.py (path:/tmp/pip-4cvpsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:00 INFO - Running setup.py (path:/tmp/pip-nQnYzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:00 INFO - Running setup.py (path:/tmp/pip-1MWjTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:00 INFO - Running setup.py (path:/tmp/pip-22Dwny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:00 INFO - Running setup.py install for manifestparser 11:07:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:00 INFO - Running setup.py install for mozcrash 11:07:00 INFO - Running setup.py install for mozdebug 11:07:00 INFO - Running setup.py install for mozdevice 11:07:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozfile 11:07:01 INFO - Running setup.py install for mozhttpd 11:07:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozinfo 11:07:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozInstall 11:07:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozleak 11:07:01 INFO - Running setup.py install for mozlog 11:07:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for moznetwork 11:07:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:01 INFO - Running setup.py install for mozprocess 11:07:01 INFO - Running setup.py install for mozprofile 11:07:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for mozrunner 11:07:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Running setup.py install for mozscreenshot 11:07:02 INFO - Running setup.py install for moztest 11:07:02 INFO - Running setup.py install for mozversion 11:07:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:02 INFO - Cleaning up... 11:07:02 INFO - Return code: 0 11:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:02 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:07:02 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 11:07:02 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 11:07:02 INFO - Using env: {'DISPLAY': ':0', 11:07:02 INFO - 'HOME': '/home/cltbld', 11:07:02 INFO - 'LANG': 'en_US.UTF-8', 11:07:02 INFO - 'LANGUAGE': 'en_US:en', 11:07:02 INFO - 'LOGNAME': 'cltbld', 11:07:02 INFO - 'MAIL': '/var/mail/cltbld', 11:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:02 INFO - 'MOZ_NO_REMOTE': '1', 11:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:02 INFO - 'NO_EM_RESTART': '1', 11:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:02 INFO - 'PWD': '/builds/slave/test', 11:07:02 INFO - 'SHELL': '/bin/bash', 11:07:02 INFO - 'SHLVL': '1', 11:07:02 INFO - 'TERM': 'linux', 11:07:02 INFO - 'TMOUT': '86400', 11:07:02 INFO - 'USER': 'cltbld', 11:07:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:02 INFO - '_': '/tools/buildbot/bin/python'} 11:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:02 INFO - Running setup.py (path:/tmp/pip-Lb7reE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:02 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)) 11:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:02 INFO - Running setup.py (path:/tmp/pip-yD5eJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:02 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)) 11:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:02 INFO - Running setup.py (path:/tmp/pip-8LwtXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:02 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)) 11:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:02 INFO - Running setup.py (path:/tmp/pip-diF1iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:02 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)) 11:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:02 INFO - Running setup.py (path:/tmp/pip-kcnEpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:03 INFO - Running setup.py (path:/tmp/pip-jhEkDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:03 INFO - Running setup.py (path:/tmp/pip-dGWuyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:03 INFO - Running setup.py (path:/tmp/pip-zVVfut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:03 INFO - Running setup.py (path:/tmp/pip-zeGqG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:03 INFO - Running setup.py (path:/tmp/pip-WcAFK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:03 INFO - Running setup.py (path:/tmp/pip-NNF6pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:03 INFO - Running setup.py (path:/tmp/pip-0wgH9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:03 INFO - Running setup.py (path:/tmp/pip-VAgMNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:03 INFO - Running setup.py (path:/tmp/pip-4DomZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:03 INFO - Running setup.py (path:/tmp/pip-XqmgRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:03 INFO - Running setup.py (path:/tmp/pip-fivjfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:03 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)) 11:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:03 INFO - Running setup.py (path:/tmp/pip-aK2MzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:03 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)) 11:07:03 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)) 11:07:03 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)) 11:07:03 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)) 11:07:03 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)) 11:07:03 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)) 11:07:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:05 INFO - Downloading blessings-1.6.tar.gz 11:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:05 INFO - Installing collected packages: blessings 11:07:05 INFO - Running setup.py install for blessings 11:07:05 INFO - Successfully installed blessings 11:07:05 INFO - Cleaning up... 11:07:06 INFO - Return code: 0 11:07:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:06 INFO - Reading from file tmpfile_stdout 11:07:06 INFO - Current package versions: 11:07:06 INFO - argparse == 1.2.1 11:07:06 INFO - blessings == 1.6 11:07:06 INFO - blobuploader == 1.2.4 11:07:06 INFO - docopt == 0.6.1 11:07:06 INFO - functools32 == 3.2.3-2 11:07:06 INFO - jsonschema == 2.5.1 11:07:06 INFO - manifestparser == 1.1 11:07:06 INFO - mozInstall == 1.12 11:07:06 INFO - mozcrash == 0.17 11:07:06 INFO - mozdebug == 0.1 11:07:06 INFO - mozdevice == 0.48 11:07:06 INFO - mozfile == 1.2 11:07:06 INFO - mozhttpd == 0.7 11:07:06 INFO - mozinfo == 0.9 11:07:06 INFO - mozleak == 0.1 11:07:06 INFO - mozlog == 3.2 11:07:06 INFO - moznetwork == 0.27 11:07:06 INFO - mozprocess == 0.22 11:07:06 INFO - mozprofile == 0.28 11:07:06 INFO - mozrunner == 6.11 11:07:06 INFO - mozscreenshot == 0.1 11:07:06 INFO - mozsystemmonitor == 0.3 11:07:06 INFO - moztest == 0.7 11:07:06 INFO - mozversion == 1.4 11:07:06 INFO - psutil == 3.1.1 11:07:06 INFO - requests == 1.2.3 11:07:06 INFO - wsgiref == 0.1.2 11:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:06 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 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:07:06 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 11:07:06 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 11:07:06 INFO - Using env: {'DISPLAY': ':0', 11:07:06 INFO - 'HOME': '/home/cltbld', 11:07:06 INFO - 'LANG': 'en_US.UTF-8', 11:07:06 INFO - 'LANGUAGE': 'en_US:en', 11:07:06 INFO - 'LOGNAME': 'cltbld', 11:07:06 INFO - 'MAIL': '/var/mail/cltbld', 11:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:06 INFO - 'MOZ_NO_REMOTE': '1', 11:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:06 INFO - 'NO_EM_RESTART': '1', 11:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:06 INFO - 'PWD': '/builds/slave/test', 11:07:06 INFO - 'SHELL': '/bin/bash', 11:07:06 INFO - 'SHLVL': '1', 11:07:06 INFO - 'TERM': 'linux', 11:07:06 INFO - 'TMOUT': '86400', 11:07:06 INFO - 'USER': 'cltbld', 11:07:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:06 INFO - '_': '/tools/buildbot/bin/python'} 11:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 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)) 11:07:06 INFO - Cleaning up... 11:07:06 INFO - Return code: 0 11:07:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:07: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', 'jsonschema'] in /builds/slave/test/build 11:07: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 jsonschema 11:07:06 INFO - Using env: {'DISPLAY': ':0', 11:07:06 INFO - 'HOME': '/home/cltbld', 11:07:06 INFO - 'LANG': 'en_US.UTF-8', 11:07:06 INFO - 'LANGUAGE': 'en_US:en', 11:07:06 INFO - 'LOGNAME': 'cltbld', 11:07:06 INFO - 'MAIL': '/var/mail/cltbld', 11:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:06 INFO - 'MOZ_NO_REMOTE': '1', 11:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:06 INFO - 'NO_EM_RESTART': '1', 11:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:06 INFO - 'PWD': '/builds/slave/test', 11:07:06 INFO - 'SHELL': '/bin/bash', 11:07:06 INFO - 'SHLVL': '1', 11:07:06 INFO - 'TERM': 'linux', 11:07:06 INFO - 'TMOUT': '86400', 11:07:06 INFO - 'USER': 'cltbld', 11:07:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:06 INFO - '_': '/tools/buildbot/bin/python'} 11:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:07:06 INFO - Cleaning up... 11:07:06 INFO - Return code: 0 11:07:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7a7920f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ca2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, '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': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', '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 11:07: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', 'flake8'] in /builds/slave/test/build 11:07: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 flake8 11:07:06 INFO - Using env: {'DISPLAY': ':0', 11:07:06 INFO - 'HOME': '/home/cltbld', 11:07:06 INFO - 'LANG': 'en_US.UTF-8', 11:07:06 INFO - 'LANGUAGE': 'en_US:en', 11:07:06 INFO - 'LOGNAME': 'cltbld', 11:07:06 INFO - 'MAIL': '/var/mail/cltbld', 11:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:06 INFO - 'MOZ_NO_REMOTE': '1', 11:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:06 INFO - 'NO_EM_RESTART': '1', 11:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:06 INFO - 'PWD': '/builds/slave/test', 11:07:06 INFO - 'SHELL': '/bin/bash', 11:07:06 INFO - 'SHLVL': '1', 11:07:06 INFO - 'TERM': 'linux', 11:07:06 INFO - 'TMOUT': '86400', 11:07:06 INFO - 'USER': 'cltbld', 11:07:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:06 INFO - '_': '/tools/buildbot/bin/python'} 11:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:06 INFO - Downloading/unpacking flake8 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:07:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:07:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07: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 11:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:09 INFO - no previously-included directories found matching 'docs/_build' 11:07:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:07:09 INFO - Running setup.py install for pep8 11:07:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:07:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:07:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:07:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:07:10 INFO - no previously-included directories found matching 'docs/_build' 11:07:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:07:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:07:10 INFO - Cleaning up... 11:07:10 INFO - Return code: 0 11:07:10 INFO - Running post-action listener: _resource_record_post_action 11:07:10 INFO - Running post-action listener: _start_resource_monitoring 11:07:10 INFO - Starting resource monitoring. 11:07:10 INFO - ##### 11:07:10 INFO - ##### Finished create-virtualenv step (success) 11:07:10 INFO - ##### 11:07:10 INFO - ##### 11:07:10 INFO - ##### Running install step. 11:07:10 INFO - ##### 11:07:10 INFO - Running pre-action listener: _resource_record_pre_action 11:07:10 INFO - Running main action method: install 11:07:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:11 INFO - Reading from file tmpfile_stdout 11:07:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:11 INFO - Reading from file tmpfile_stdout 11:07:11 INFO - Output received: 11:07:11 INFO - Usage: mozinstall [options] installer 11:07:11 INFO - Options: 11:07:11 INFO - -h, --help show this help message and exit 11:07:11 INFO - -d DEST, --destination=DEST 11:07:11 INFO - Directory to install application into. [default: 11:07:11 INFO - "/builds/slave/test"] 11:07:11 INFO - --app=APP Application being installed. [default: firefox] 11:07:11 INFO - mkdir: /builds/slave/test/build/application 11:07:11 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'] 11:07:11 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 11:07:27 INFO - Reading from file tmpfile_stdout 11:07:27 INFO - Output received: 11:07:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:27 INFO - Running post-action listener: _resource_record_post_action 11:07:27 INFO - ##### 11:07:27 INFO - ##### Finished install step (success) 11:07:27 INFO - ##### 11:07:27 INFO - ##### 11:07:27 INFO - ##### Running run-tests step. 11:07:27 INFO - ##### 11:07:27 INFO - Running pre-action listener: _resource_record_pre_action 11:07:27 INFO - Running main action method: run_tests 11:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:27 INFO - Python 2.7.3 11:07:27 INFO - Return code: 0 11:07:27 INFO - grabbing minidump binary from tooltool 11:07:27 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')]} 11:07:27 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 0x16c4e20>, '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 0x16c83a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c8830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:27 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 11:07:27 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 11:07:27 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 11:07:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:27 INFO - Return code: 0 11:07:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:07:28 INFO - Return code: 0 11:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:07:28 INFO - Using env: {'DISPLAY': ':0', 11:07:28 INFO - 'HOME': '/home/cltbld', 11:07:28 INFO - 'LANG': 'en_US.UTF-8', 11:07:28 INFO - 'LANGUAGE': 'en_US:en', 11:07:28 INFO - 'LOGNAME': 'cltbld', 11:07:28 INFO - 'MAIL': '/var/mail/cltbld', 11:07:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:28 INFO - 'MOZ_NO_REMOTE': '1', 11:07:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:28 INFO - 'NO_EM_RESTART': '1', 11:07:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:28 INFO - 'PWD': '/builds/slave/test', 11:07:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:28 INFO - 'SHELL': '/bin/bash', 11:07:28 INFO - 'SHLVL': '1', 11:07:28 INFO - 'TERM': 'linux', 11:07:28 INFO - 'TMOUT': '86400', 11:07:28 INFO - 'USER': 'cltbld', 11:07:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466099607.43586-44492617', 11:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:28 INFO - '_': '/tools/buildbot/bin/python'} 11:07:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:07:28 INFO - mozversion application_buildid: 20160616103225 11:07:28 INFO - mozversion application_changeset: 942a42c22de790ca091f1e329250ef11217636bc 11:07:28 INFO - mozversion application_display_name: Nightly 11:07:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:28 INFO - mozversion application_name: Firefox 11:07:28 INFO - mozversion application_remotingname: firefox 11:07:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:07:28 INFO - mozversion application_vendor: Mozilla 11:07:28 INFO - mozversion application_version: 50.0a1 11:07:28 INFO - mozversion platform_buildid: 20160616103225 11:07:28 INFO - mozversion platform_changeset: 942a42c22de790ca091f1e329250ef11217636bc 11:07:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:07:28 INFO - mozversion platform_version: 50.0a1 11:07:28 INFO - using testdate: 1466100448 11:07:28 INFO - actual date: 1466100448 11:07:28 INFO - starting webserver on 'localhost:50281' 11:07:28 INFO - SUITE-START | Running 2 tests 11:07:28 INFO - TEST-START | dromaeo_css 11:07:28 INFO - operating with platform_type : linux_ 11:07:28 INFO - Initialising browser for dromaeo_css test... 11:07:28 INFO - TEST-INFO | started process 17157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCPZZg4/profile http://localhost:50281/getInfo.html) 11:07:32 INFO - PROCESS | 17157 | __metrics Screen width/height:1600/1200 11:07:32 INFO - PROCESS | 17157 | colorDepth:24 11:07:32 INFO - PROCESS | 17157 | Browser inner width/height: 1024/697 11:07:32 INFO - PROCESS | 17157 | __metrics 11:07:33 INFO - PROCESS | 17157 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:34 INFO - TEST-INFO | 17157: exit 0 11:07:34 INFO - Browser initialized. 11:07:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:07:34 INFO - TEST-INFO | started process 17237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCPZZg4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:46 INFO - PROCESS | 17237 | RSS: Main: 176070656 11:07:46 INFO - PROCESS | 17237 | 11:08:38 INFO - PROCESS | 17237 | 1466100518098 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] 11:10:51 INFO - PROCESS | 17237 | Cycle 1(1): loaded http://localhost:50281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50281/tests/dromaeo/cssquery-ext.html) 11:10:52 INFO - PROCESS | 17237 | RSS: Main: 263249920 11:10:52 INFO - PROCESS | 17237 | 11:13:54 INFO - PROCESS | 17237 | Cycle 1(1): loaded http://localhost:50281/tests/dromaeo/cssquery-ext.html (next: http://localhost:50281/tests/dromaeo/cssquery-jquery.html) 11:13:55 INFO - PROCESS | 17237 | RSS: Main: 258334720 11:13:55 INFO - PROCESS | 17237 | 11:16:57 INFO - PROCESS | 17237 | Cycle 1(1): loaded http://localhost:50281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50281/tests/dromaeo/cssquery-mootools.html) 11:16:58 INFO - PROCESS | 17237 | RSS: Main: 266457088 11:16:58 INFO - PROCESS | 17237 | 11:20:00 INFO - PROCESS | 17237 | Cycle 1(1): loaded http://localhost:50281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50281/tests/dromaeo/cssquery-prototype.html) 11:20:00 INFO - PROCESS | 17237 | RSS: Main: 252899328 11:20:00 INFO - PROCESS | 17237 | 11:23:03 INFO - PROCESS | 17237 | Cycle 1(1): loaded http://localhost:50281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50281/tests/dromaeo/cssquery-yui.html) 11:23:04 INFO - PROCESS | 17237 | RSS: Main: 239300608 11:23:04 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | Cycle 1(1): loaded http://localhost:50281/tests/dromaeo/cssquery-yui.html (next: http://localhost:50281/tests/dromaeo/cssquery-dojo.html) 11:26:07 INFO - PROCESS | 17237 | RSS: Main: 307961856 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | __start_tp_report 11:26:07 INFO - PROCESS | 17237 | _x_x_mozilla_page_load 11:26:07 INFO - PROCESS | 17237 | _x_x_mozilla_page_load_details 11:26:07 INFO - PROCESS | 17237 | |i|pagename|runs| 11:26:07 INFO - PROCESS | 17237 | |0;dojo.html;2640.577507598784;2642.260167153198;2684.9328766780827;2696.7707744841673;2701.1896431070672;4581.381513495677;4653.813847446098;4765.547273009063;4783.617310615146;4849.393825771778;4723.645726570512;4730.219513780231;4735.3133795599615;4787;4790.305405716169;4309.0735491869245;4393.1213757248515;4411.6250118739945;4434.224010798113;4564.018735971766;4451.421315229016;4469.217886869801;4513.435820522434;4525;4543.204939135655;4285.164392943378;4330.870073897788;4344.304911214191;4371.038371558252;4382.802773875183;4290.978545107255;4305.289627211507;4343.609075183217;4367.3667318238995;4373.606375426195;4322.589354011364;4330.285502892019;4344.500382456026;4378.759168245745;4378.759168245745;4584.977075114636;4698.600618947394;4749.311349854252;4757.690750101232;4823.638227132979;5147.536721695065;5148.2020286855595;5167.0957582422925;5167.431582525919;5188.92216616751;5010.3737032870895;5142.640015198937;5213.608979326527;5230.189320655267;5234.633575649668;4756.714597124149;4794.640401969797;4799.448063472745;4811.927821082687;4859.684120532154;5281.9207711884355;5288.3918349390315;5303.04545181871;5303.973480132575;5318.095923692981;4938.827141050046;5046.823361182341;5055.51972562606;5074.035933172685;5120.462351453119;5154.252633368141;5160.974195129075;5178.430372659004;5185.766640501187;5231.346081739783;5093.617978651616;5107.974460127675;5110.770015349318;5136.717480538607;5160.40655324635;4932.1122198004705;5013.222950442687;5054.317667114966;5099.464556221617;5106.234064890222;4301.720388174821;4317.222899877989;4324.870253892388;4362.956370436318;4367.5632436756705;3753.6997040236715;3777;3778.301014312306;3814.904627384282;3821;4320.848770293024;4370.868873933787;4388.583084607021;4401.515833258339;4415.580519850609;5155.149400348975;5177.223416487482;5189.247559103909;5191.636585439059;5226.111561034633;4417.60241578253;4423.1153769246275;4425.09285596452;4457.3091170868565;4472.955270447319;4485.327200919888;4615.30770384445;4620.283856002325;4646.976765116153;4655.3947986761505;4861.392325959255;4868.2210846264425;4876.926846097312;4886.780094895667;4913.140200464976;5208.557272631869;5231.947680523146;5232.9738351308;5234.764435600331;5235.895282094413;4707.6704630676895;4796.688215265996;4835.032993401404;4846.055019271349;4873.049755297683;5049.873753156054;5066.341375621146;5073.315102461268;5085.389753229636;5125.564327032244;5034.773435195351;5148.922766158586;5187.377514698261;5189.4032186297545;5191.844244672666;4962.975185124052;4975.825846095369;4978.2781496682055;4985.077760614298;5003.299538064746;5007.724575148256;5017.247412888096;5021.096202683552;5021.6735912165595;5069.518395752398;4780.521947805191;4843.321934929183;4893.143699852582;4902.1911384621135;4972.0801651694555;5012.223105418666;5021.6484846061885;5037.219231019198;5047.444781074152;5090.211017292326;4910.410750709938;4913.091078150554;4916.262560615936;4931.827386041615;4993.101241776515 11:26:07 INFO - PROCESS | 17237 | |1;ext.html;559.6725915339526;574.4198359656747;590.8759160576279;602.3494625804132;611.1413464082963;28557.143285701437;31629.84185079077;31697.36605267893;31855.52216716745;32049;31877.36245275093;32279.51580726285;40244.597554024454;41255.38116928248;41653;7791.961040194805;7901.367890568741;7902.170272121431;7918.089419716749;7920.366370690331;7738.61306934651;7743.264389882952;7805.60971951403;7823.608819559027;7831.41264405169;7668.769936901902;7864.882026769603;7868.921310786876;8074.919250807476;9946.353487023356;9743.464109473976;10137.847932281022;10150.746231344201;10162.136218421443;10169.033941775482;10041.096301332915;10137.89862101377;10149.543270552844;10155.28912976092;10156.746081347952;29613.259668508243;38202.42696359529;38804.61195388038;39028.609713902784;39360.21279574392;2941.9264518387;2964.019022362246;3039.8024128431803;3110.3623757129735;3471.7743346682637;29307.560386594218;29672.25819354512;29684.70315296841;29856.253593660116;32825.83587082073;3300.5874265716784;3477.6174620791694;3585.8386372613295;3615.8011309377976;3630.818459077062;259105;260098;260181;260250;261849.9999999981;31889.681103189134;32777.18057048593;32831.50752738711;34678.653213468046;56104.438955610734;33986.49020264698;34021.489677654856;34093.318133637185;34128;34172.14569635729;12910.096293259381;13039.674008149872;13043.673908152372;13053.804192937114;13069.954403647685;10654.89345106539;10725.892741072645;10810.0270975611;10810.081143102925;10820.35077895313;7884.132745398002;7908.090569584457;7918.208179182036;7975.641096150687;7983.72056978003;2889.0899366699423;3075.169704179859;3124.265797537577;3124.703153200442;3140.811551306929;809.514291425152;819.8729196974479;908.8366890380191;949.6343907595625;989.737719504332;26506.602400964002;26636.843839555822;27244.863775680995;28523.286917826805;28662.713372866423;922.4834092907993;944.617429940875;972.8832540095092;976.4336684722844;1003.5333569890037;14673.633159170893;14878.553643390716;14939.925300373428;15152;15262.236888155549;408241;413095;413805;413832;414403;43578.78210608927;50069.24896126561;50368.740781480024;50395.74802125966;50471.24293135606;1126.7014241226082;1151.6775302915198;1157.1668398752884;1158.206628459508;1167.0197034491068;28276;28526.85736571304;28826.59563303074;29030.7096929028;29132.27169320784;43272.35091473693;43630;43944.56055439533;44127;44132;368320;374119;393116;557085;571055;37713.81143094267;38763.80618096892;38767;38774.80612596919;38785.2242955145;42952.35571466493;42987;43054.35418468663;43681.12637747291;43906.56093439025;36067.27865442729;37090.62909370872;37320;37325.62674373222;37615.2476950454;35993;36172;36437.27125457529;36685.63314366822;36809.81595092115;35630.28739425249;35894.64105358913;35920;36850;37776;31883.681163188998;33144;33470.330593388484;33546.83226583949;34029.31941361209;25658.61512077283;25680.486390272465;25689.229323120337;25714.10000650043;25903 11:26:07 INFO - PROCESS | 17237 | |2;jquery.html;367.3406235806727;367.8749225263411;369.7116249325527;378.7992364047054;381.281284778193;16283.185840707962;16303.510894673163;16996.915015424907;17010.40463583775;17030.48908532743;14605.342759575818;15178.848211517881;15306.617334566641;15355.462558810445;15733.685326293467;4919.557239848422;5283.313169287987;5283.498067683564;5322.520973112419;5332.306800115999;3779.8866034019024;3961;5185.066687996159;5867.589268751189;6196.039613859859;6205.22434695663;6207.782727604535;6231.937680623204;6240.4071613196675;6242.063690446424;5947.286325640929;6133.294671112834;6140.969295153518;6143.539234557426;6150.753969841178;3395.9830200848837;5188.507091826271;5391.622586418952;5505.119180931072;5515.751791169367;17224.224909879085;17235.91382043082;17719.468415947413;19730.112144953513;19840.50398740043;2075.3877606106234;2205.4817117977263;2217.013429024085;2367.893444794971;2535.8858851351547;12779.424925878358;12953.805692914613;13109;13125.60623181306;13671.726565468634;1734.8698847586356;1795.2190797003345;1843.1060935446299;1852.7776666799934;1859.981400186008;58133.418665813224;58492;58577.70711146417;60648.999999999556;61077;9036.367454278268;9372.953135234417;9611.134997850228;9900.356476828983;10456.163506919429;13123.278219697817;13226.867731322563;13230.338483075808;13232.13991090576;13235.933820331029;6949.7567585134275;6987.406070483964;7061.293870613001;7081.716731330689;7116.857662846817;6598.901016484757;6623.834404139839;6795.252522222551;6797.93202067973;6798.592084474947;5904.9704751475965;6045.486133678599;6123.234595675541;6133.754649814046;6207.441330280297;1634.6648936967892;1704.241612482458;1759.9032053237195;1782.1089455272363;1792.7579776730236;826.8181000179951;842.1326034184799;878.5255961780695;886.5389997201419;905.8867641544807;16179.757303640456;16571.91714041422;16940.322387104377;17072.658546828992;18062.90968545149;805.524740403165;808.1514409869731;858.9785255368665;859.7721603774879;901.2924853989717;9310.72067837966;9469;9771.364861283993;9824.312298139062;9999.050090241415;352438;353097;354019;375570;384957;44555.55444445514;59203.70398148068;75460.24539754532;75578;78772;871.7254064969641;903.5301643145527;908.2924102686907;915.2860768600502;917.4036876030633;15640.765388519409;15905.602359941095;15905.840941590435;15915.124668143364;16164.272607732444;25626.359341016625;26870.865645672427;35063.29873402569;37583.43624845684;37739.81130094332;46383;48339.274910877066;52395;52556;53429;6673.1324927761025;7057.294270573107;7145.142582889878;7314.6708398121145;7665.080190377191;11596.88403115958;11606.593769218036;11961.162718609614;12255.87744122583;12296.569620063256;10245.692629221136;10442.68671939843;10552.525136368728;10606.204534659777;10638.574457021632;10388.37669739818;10447.738806529898;10522.31604945676;10735.892641073802;10753.46232688378;10124.746881328027;10205.183585313305;10311.329763565343;10668.466576671291;10956.780864382508;7083.433325334064;7253.673584688807;7267.236940121211;7338;7437.590932498764;10556.313839600401;10563.15494760402;10580.788384232426;10620.09729173029;10639.095676867553 11:26:07 INFO - PROCESS | 17237 | |3;mootools.html;1219.8658147603767;1386.542440994472;1410.4428750643497;1481.6592183797727;1676.6562854614806;6680.465562754974;7668;7906.841863162747;7920.722774702886;8142.674293028286;7896.407769417288;7999;8073.878891816613;8076.757697269091;8080.272775450223;2215.977840221601;2247.4606094537357;2249.640057590786;2253.177590179589;2253.661950707399;2156.91372345106;2158.84888057836;2162.740471143457;2163.3834357208198;2222.122261706625;2212.9557408851815;2237.798598126168;2243.921462748804;2249.49386388063;2250.426141333966;2142.4215461825297;2144.9356519304447;2150.064721846002;2150.1506904772605;2151.806337429639;2158.4711745622267;2181.3564998325373;2206.1396055538353;2216.3240211735415;2218.3234113595345;7767.8446431071625;8003.95998020012;8058.11360750317;8062.919370806276;8065.39509536787;4502.2121128802655;4621.69958952667;4634.443866735979;4640.443146822403;4647.093816705744;2737.178846346088;2799.440111977592;2874.9937521867387;2876.3384421583155;2883.264767484299;928.3037721708719;934.9018353072897;940.6519587752575;942.0250041207386;944.9149576538076;10552.894471055268;10629.202809789296;10674.626388076458;10682.732931676692;10684.786304273872;3969.861054863066;4059.6143366380147;4112.732672376286;4147.605977432139;4151.626353628188;8461.407701460961;8498.405111642125;8502.489850608983;8509.149085091442;8517.659293628185;4349.826006959749;4387.802548885244;4395.7142785718825;4398.47218333802;4399.6040356368085;3563.1448452371765;3992.7205095643026;4032.334664780278;4100.712950093465;4132.690048246393;3478.339115568034;3481.8433170507387;3565.625609311037;3586.5875424326537;3587.1390866191928;1054.783769327286;1073.4632683658172;1083.669480808361;1092.63396762084;1092.7268182954263;824.5382585751878;825.2778818533783;839.7480755773244;841.9284360829398;859.4499520307008;5073.492650734897;5169.896602067937;5193.948060519422;5293.523582877559;5367.329083864517;404.43177335842597;414.3742948148318;419.16795161604193;420.42611834845826;425.61694474972154;3427;3460.2041530448137;3489.2149266415363;3499.702525285379;3585.15748799032;9473.100055494717;9810.362326448758;9928.453935033642;9959;9975.052370024836;9821.607135714634;9833.557489912972;9846.261530385249;9849.50752462374;9861.753456163653;7251.782446526508;7316.085489313836;7416.22129676387;7425.9628701856145;7435.7769266921;5070.442251352422;5156.56169225605;5165.896682066413;5220.243064755665;5243.921341179962;8915.509646969478;8956.865647015431;9011.594478248626;9112.362134650512;9149.5882685278;9073.954630226806;9166.862497062417;9170.495622740813;9181.724548263563;9456.810863782823;5717.885642287214;5819.738111785065;5821.94178058231;6536.7712130075215;6612.173478315211;7195.532290401107;7264.237255088351;7312.926870731225;7552.320291173821;7556.546607203585;6930.410915072275;7011.193712723102;7062.8940565890525;7155.964220179074;7175;6830.419414349836;6834.794956151323;6836.111305530249;6981.7207311709;7064.081669382947;6457.128287681103;6497.415232629086;6502.3172566881685;6505.381988711065;6570.934290657032;4463.107378524243;4528.864134075983;4561.49823519406;4592.288195329729;4636.235021221595;4498.167838949805;4514.367988481549;4549.408576884984;4550.977245113753;4587.288970209623 11:26:07 INFO - PROCESS | 17237 | |4;prototype.html;283.85807096451776;289.87680235899745;296.20321335607207;298.81473486438387;300.05183619761556;4733.337332773414;4906.828261010865;4918.581920536754;4980.153373926432;5013.473585273544;4715.174844402224;4827.251775974721;4896.241082632188;4900.779464924078;4904.828331008415;3875.8255878485393;3876.759436980153;3878.941815872764;3880.2821478026513;3883.631055049773;3670.889873303792;3742.569604495477;3857.1514266861386;3878.7672739635573;3888.7083468739957;3835.5780864104927;3846.7114966377494;3864.265789499986;3864.3623802072625;3875.8837234883;3834.9041273968096;3843.135294558716;3854.7664747280883;3856.8842934712;3872.6514613684903;3370.7808992415416;3392.3724111039537;3413.453847384407;3421.1105112670884;3421.349943510725;4574.039451715111;4720.834770783041;4759.23852183649;4767.976160119178;4777.856664300077;4249.277622804131;4273.038566322583;4289.2922667759785;4290.2706539888295;4305.203537345601;5033.597312215051;5076.213186956028;5120.948790512121;5133.974330128362;5160.303359046518;3607.8556857725657;3691.187938653492;3732.328180927432;3734.9253014939823;3749.3063783200196;5314.60140489461;5370.087085195487;5383.67697938125;5401.70290634015;5407.404815579374;3792.1657235408165;3794.772313661189;3838.3858582626644;3850.0759817643566;3850.152966347399;3796.354619714655;3867.535895692479;3879.321118804198;3884.9122245771227;3893.201893611803;4345.478542574911;4376.3654270130655;4378.5183629800695;4379.1460665170625;4390.8024138913825;5124.282600435942;5137.40919794221;5156.458571849902;5175.948240517622;5178.818741344035;1248.637895010455;1293.4308904082175;1311.7901135818224;1312.2284915364373;1319.630503459033;817.8814071959532;831.6548632317521;835.3317346123077;845.8139209373928;853.4665833853842;4030.717849750548;4047.866597352746;4055.8238110947495;4058.188362327546;4105.4252404663375;4667.299905014207;4674.275487299474;4688.57802797743;4717.386739723883;4727.2436410174205;4027.2146931348693;4028.576999415078;4031.455753473302;4052.986753311672;4061.2283666103344;2330.8251881108986;2453.889574969095;2470.4564995700916;2481.163938685396;2495.2015355086196;4312.137572485515;4344.630706389929;4377.343398490252;4385.364122202327;4389.344446609819;4687.554682305175;4713.198756211384;4714.114354258256;4737.2183589708;4747.548982846693;4349.216821103332;4376.212281789309;4608.400907881954;5057.671251368723;5068.467810879804;5299.5230429261555;5300.443453437333;5320.962412329559;5338.199270109515;5362.65142765719;5171.482851714798;5183.222516622386;5195.7142357170715;5195.7142357170715;5216.608754343363;4695.718256904596;4960.553550180501;5004.048421115695;5008.524190201925;5012.974935125447;3677.5035370224678;3693.1136527233807;3696.8706095286534;3705.81470926458;3707.295613833363;5069.518395752398;5303.515015795583;5317.946820531745;5324.1747529133045;5344.331958505187;5016.122178618654;5046.29351890743;5056.662602682212;5110.540051395392;5137.486251374833;5147.433782283871;5148.665336753099;5201.453847346125;5208.479152084761;5235.895282094413;4899.338589290543;5087.54212120896;5090.465501122477;5103.724068982754;5108.438071812172;5207.192885102815;5210.635255532076;5210.6613070150315;5236.293100431393;5239.502247286502;5061.4938506150565;5089.592832573311;5097.617678674188;5119.436861945109;5120.078385890575 11:26:07 INFO - PROCESS | 17237 | |5;yui.html;664.5082638847251;687.5805758487325;711.3988679565766;720.229354590588;721.5165838887945;12692;13606.455741770318;13614.251216183105;13631.727365452685;13639;13004.154729942571;13099.148555343896;13121.47514099435;13145.60563183106;13157.079004469691;622.0296337713182;622.3714048810712;741.7366834773659;751.5490705576665;780.7657702689199;782.284209947897;789.2383849585149;796.2952786783709;797.5693125712138;797.7606717984611;658.6476235214161;845.0239972831359;846.4624963148384;846.851800934837;846.8729690546405;803.2690251870798;822.3708862720054;829.0217543298905;829.4857188543082;830.1366578758084;605.1195510532209;606.4663096475118;608.0544752909268;609.9481544068759;611.3122736920964;13016;13047.739045219138;13083.149595276373;13089.34553272342;13094.869051309555;12669;13034.543790967271;13108.934455327757;13112.147710398793;13379.799303010463;11715.968671111426;11806.23259488139;11833.526658933632;12052;12429.502819887193;4279.7218180818145;4322.265214913441;4328.329108988112;4334.544872788375;4367.716098453622;59732.701336493476;60698.69650651718;61043.69478152581;61111.69444152751;61207.38792612062;10057.29598928068;10247.538860751136;10271.332363396505;10275.845862312071;10610.20423468243;16993.575160620836;17842.286308547773;18516.907415462836;18578.349757758413;18583.44249672512;6946.652667366611;6954.09596752429;7002.474814388839;7008.123984501937;7048.436125109979;3776.2825063237897;3800.3729384651224;3847.74989625679;3866.420036994417;3901.7463864848696;2887.956680649792;2985.9850700746792;2986.566947792558;2987.342784587387;2990.1478078747455;509.2691986998669;509.5795968326072;511.3046257090354;528.0205219318186;529.1242992846844;466.2097744323339;481.4343146802493;538.68217751526;543.4918351341508;553.590343146069;7751.342288577042;7894.960525197337;8063.919360806317;8115.837683246302;8329.125441828643;452.29667866467304;479.60672248755685;479.8080767692951;521.8382301486552;576.3429690153229;3701.759385639925;3944.073142811437;3949.3483575210344;3994.9001274967777;4048.7570745755347;90987.09012909787;91533.54233228925;92320.53839730758;92838;94736;79237.60381198057;79355.60322198352;80636;82824.58587707144;83262;42845;69575.65212173907;71518.28481715116;71748.2825171752;72098.27901720916;7310.451716121206;7361;7538.698452061856;7628.199039100815;7645.808854778675;41201.38197926973;41606.37590436207;42350.36474452824;43535.346969794846;43771.78114109409;52298.477015229364;62759;63042.36957630365;63539;64217;8940.910590894007;9372.203362713974;10863.945680271549;11086.057685096857;11794.05647548177;12439.875601243872;12450.75098498043;12791.104622676696;12989;13140.27728474943;11918.642440726791;11965.641030769091;12675.80986285188;12698.682532936751;12930.071353734938;12271.202371846159;12357.135000550235;12537.498500059895;12696.555620553236;13039.47842086344;11830.036194159558;12090.725175092604;12119.212251203644;12240.331108778711;12449.688757780765;10229.539670714687;10425.374477531372;10513.789724205626;10672.83990740155;10768;10563.524641391003;10653.627123050655;10759.946200268949;10880.564777408816;10886 11:26:07 INFO - PROCESS | 17237 | __end_tp_report 11:26:07 INFO - PROCESS | 17237 | __start_cc_report 11:26:07 INFO - PROCESS | 17237 | _x_x_mozilla_cycle_collect,903 11:26:07 INFO - PROCESS | 17237 | __end_cc_report 11:26:07 INFO - PROCESS | 17237 | __startTimestamp1466101567660__endTimestamp 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | ------- Summary: start ------- 11:26:07 INFO - PROCESS | 17237 | Number of tests: 6 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | [#0] dojo.html Cycles:165 Average:4739.51 Median:4868.22 stddev:509.63 (10.5%) stddev-sans-first:483.86 11:26:07 INFO - PROCESS | 17237 | Values: 2640.6 2642.3 2684.9 2696.8 2701.2 4581.4 4653.8 4765.5 4783.6 4849.4 4723.6 4730.2 4735.3 4787.0 4790.3 4309.1 4393.1 4411.6 4434.2 4564.0 4451.4 4469.2 4513.4 4525.0 4543.2 4285.2 4330.9 4344.3 4371.0 4382.8 4291.0 4305.3 4343.6 4367.4 4373.6 4322.6 4330.3 4344.5 4378.8 4378.8 4585.0 4698.6 4749.3 4757.7 4823.6 5147.5 5148.2 5167.1 5167.4 5188.9 5010.4 5142.6 5213.6 5230.2 5234.6 4756.7 4794.6 4799.4 4811.9 4859.7 5281.9 5288.4 5303.0 5304.0 5318.1 4938.8 5046.8 5055.5 5074.0 5120.5 5154.3 5161.0 5178.4 5185.8 5231.3 5093.6 5108.0 5110.8 5136.7 5160.4 4932.1 5013.2 5054.3 5099.5 5106.2 4301.7 4317.2 4324.9 4363.0 4367.6 3753.7 3777.0 3778.3 3814.9 3821.0 4320.8 4370.9 4388.6 4401.5 4415.6 5155.1 5177.2 5189.2 5191.6 5226.1 4417.6 4423.1 4425.1 4457.3 4473.0 4485.3 4615.3 4620.3 4647.0 4655.4 4861.4 4868.2 4876.9 4886.8 4913.1 5208.6 5231.9 5233.0 5234.8 5235.9 4707.7 4796.7 4835.0 4846.1 4873.0 5049.9 5066.3 5073.3 5085.4 5125.6 5034.8 5148.9 5187.4 5189.4 5191.8 4963.0 4975.8 4978.3 4985.1 5003.3 5007.7 5017.2 5021.1 5021.7 5069.5 4780.5 4843.3 4893.1 4902.2 4972.1 5012.2 5021.6 5037.2 5047.4 5090.2 4910.4 4913.1 4916.3 4931.8 4993.1 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | [#1] ext.html Cycles:180 Average:51036.39 Median:19740.24 stddev:103168.94 (522.6%) stddev-sans-first:103388.75 11:26:07 INFO - PROCESS | 17237 | Values: 559.7 574.4 590.9 602.3 611.1 28557.1 31629.8 31697.4 31855.5 32049.0 31877.4 32279.5 40244.6 41255.4 41653.0 7792.0 7901.4 7902.2 7918.1 7920.4 7738.6 7743.3 7805.6 7823.6 7831.4 7668.8 7864.9 7868.9 8074.9 9946.4 9743.5 10137.8 10150.7 10162.1 10169.0 10041.1 10137.9 10149.5 10155.3 10156.7 29613.3 38202.4 38804.6 39028.6 39360.2 2941.9 2964.0 3039.8 3110.4 3471.8 29307.6 29672.3 29684.7 29856.3 32825.8 3300.6 3477.6 3585.8 3615.8 3630.8 259105.0 260098.0 260181.0 260250.0 261850.0 31889.7 32777.2 32831.5 34678.7 56104.4 33986.5 34021.5 34093.3 34128.0 34172.1 12910.1 13039.7 13043.7 13053.8 13070.0 10654.9 10725.9 10810.0 10810.1 10820.4 7884.1 7908.1 7918.2 7975.6 7983.7 2889.1 3075.2 3124.3 3124.7 3140.8 809.5 819.9 908.8 949.6 989.7 26506.6 26636.8 27244.9 28523.3 28662.7 922.5 944.6 972.9 976.4 1003.5 14673.6 14878.6 14939.9 15152.0 15262.2 408241.0 413095.0 413805.0 413832.0 414403.0 43578.8 50069.2 50368.7 50395.7 50471.2 1126.7 1151.7 1157.2 1158.2 1167.0 28276.0 28526.9 28826.6 29030.7 29132.3 43272.4 43630.0 43944.6 44127.0 44132.0 368320.0 374119.0 393116.0 557085.0 571055.0 37713.8 38763.8 38767.0 38774.8 38785.2 42952.4 42987.0 43054.4 43681.1 43906.6 36067.3 37090.6 37320.0 37325.6 37615.2 35993.0 36172.0 36437.3 36685.6 36809.8 35630.3 35894.6 35920.0 36850.0 37776.0 31883.7 33144.0 33470.3 33546.8 34029.3 25658.6 25680.5 25689.2 25714.1 25903.0 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | [#2] jquery.html Cycles:180 Average:22969.69 Median:380.04 stddev:59893.73 (15759.8%) stddev-sans-first:60037.71 11:26:07 INFO - PROCESS | 17237 | Values: 367.3 367.9 369.7 378.8 381.3 16283.2 16303.5 16996.9 17010.4 17030.5 14605.3 15178.8 15306.6 15355.5 15733.7 4919.6 5283.3 5283.5 5322.5 5332.3 3779.9 3961.0 5185.1 5867.6 6196.0 6205.2 6207.8 6231.9 6240.4 6242.1 5947.3 6133.3 6141.0 6143.5 6150.8 3396.0 5188.5 5391.6 5505.1 5515.8 17224.2 17235.9 17719.5 19730.1 19840.5 2075.4 2205.5 2217.0 2367.9 2535.9 12779.4 12953.8 13109.0 13125.6 13671.7 1734.9 1795.2 1843.1 1852.8 1860.0 58133.4 58492.0 58577.7 60649.0 61077.0 9036.4 9373.0 9611.1 9900.4 10456.2 13123.3 13226.9 13230.3 13232.1 13235.9 6949.8 6987.4 7061.3 7081.7 7116.9 6598.9 6623.8 6795.3 6797.9 6798.6 5905.0 6045.5 6123.2 6133.8 6207.4 1634.7 1704.2 1759.9 1782.1 1792.8 826.8 842.1 878.5 886.5 905.9 16179.8 16571.9 16940.3 17072.7 18062.9 805.5 808.2 859.0 859.8 901.3 9310.7 9469.0 9771.4 9824.3 9999.1 352438.0 353097.0 354019.0 375570.0 384957.0 44555.6 59203.7 75460.2 75578.0 78772.0 871.7 903.5 908.3 915.3 917.4 15640.8 15905.6 15905.8 15915.1 16164.3 25626.4 26870.9 35063.3 37583.4 37739.8 46383.0 48339.3 52395.0 52556.0 53429.0 6673.1 7057.3 7145.1 7314.7 7665.1 11596.9 11606.6 11961.2 12255.9 12296.6 10245.7 10442.7 10552.5 10606.2 10638.6 10388.4 10447.7 10522.3 10735.9 10753.5 10124.7 10205.2 10311.3 10668.5 10956.8 7083.4 7253.7 7267.2 7338.0 7437.6 10556.3 10563.2 10580.8 10620.1 10639.1 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | [#3] mootools.html Cycles:180 Average:5115.94 Median:5071.97 stddev:2928.27 (57.7%) stddev-sans-first:2921.85 11:26:07 INFO - PROCESS | 17237 | Values: 1219.9 1386.5 1410.4 1481.7 1676.7 6680.5 7668.0 7906.8 7920.7 8142.7 7896.4 7999.0 8073.9 8076.8 8080.3 2216.0 2247.5 2249.6 2253.2 2253.7 2156.9 2158.8 2162.7 2163.4 2222.1 2213.0 2237.8 2243.9 2249.5 2250.4 2142.4 2144.9 2150.1 2150.2 2151.8 2158.5 2181.4 2206.1 2216.3 2218.3 7767.8 8004.0 8058.1 8062.9 8065.4 4502.2 4621.7 4634.4 4640.4 4647.1 2737.2 2799.4 2875.0 2876.3 2883.3 928.3 934.9 940.7 942.0 944.9 10552.9 10629.2 10674.6 10682.7 10684.8 3969.9 4059.6 4112.7 4147.6 4151.6 8461.4 8498.4 8502.5 8509.1 8517.7 4349.8 4387.8 4395.7 4398.5 4399.6 3563.1 3992.7 4032.3 4100.7 4132.7 3478.3 3481.8 3565.6 3586.6 3587.1 1054.8 1073.5 1083.7 1092.6 1092.7 824.5 825.3 839.7 841.9 859.4 5073.5 5169.9 5193.9 5293.5 5367.3 404.4 414.4 419.2 420.4 425.6 3427.0 3460.2 3489.2 3499.7 3585.2 9473.1 9810.4 9928.5 9959.0 9975.1 9821.6 9833.6 9846.3 9849.5 9861.8 7251.8 7316.1 7416.2 7426.0 7435.8 5070.4 5156.6 5165.9 5220.2 5243.9 8915.5 8956.9 9011.6 9112.4 9149.6 9074.0 9166.9 9170.5 9181.7 9456.8 5717.9 5819.7 5821.9 6536.8 6612.2 7195.5 7264.2 7312.9 7552.3 7556.5 6930.4 7011.2 7062.9 7156.0 7175.0 6830.4 6834.8 6836.1 6981.7 7064.1 6457.1 6497.4 6502.3 6505.4 6570.9 4463.1 4528.9 4561.5 4592.3 4636.2 4498.2 4514.4 4549.4 4551.0 4587.3 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | [#4] prototype.html Cycles:180 Average:4179.58 Median:4680.92 stddev:1223.13 (26.1%) stddev-sans-first:1191.10 11:26:07 INFO - PROCESS | 17237 | Values: 283.9 289.9 296.2 298.8 300.1 4733.3 4906.8 4918.6 4980.2 5013.5 4715.2 4827.3 4896.2 4900.8 4904.8 3875.8 3876.8 3878.9 3880.3 3883.6 3670.9 3742.6 3857.2 3878.8 3888.7 3835.6 3846.7 3864.3 3864.4 3875.9 3834.9 3843.1 3854.8 3856.9 3872.7 3370.8 3392.4 3413.5 3421.1 3421.3 4574.0 4720.8 4759.2 4768.0 4777.9 4249.3 4273.0 4289.3 4290.3 4305.2 5033.6 5076.2 5120.9 5134.0 5160.3 3607.9 3691.2 3732.3 3734.9 3749.3 5314.6 5370.1 5383.7 5401.7 5407.4 3792.2 3794.8 3838.4 3850.1 3850.2 3796.4 3867.5 3879.3 3884.9 3893.2 4345.5 4376.4 4378.5 4379.1 4390.8 5124.3 5137.4 5156.5 5175.9 5178.8 1248.6 1293.4 1311.8 1312.2 1319.6 817.9 831.7 835.3 845.8 853.5 4030.7 4047.9 4055.8 4058.2 4105.4 4667.3 4674.3 4688.6 4717.4 4727.2 4027.2 4028.6 4031.5 4053.0 4061.2 2330.8 2453.9 2470.5 2481.2 2495.2 4312.1 4344.6 4377.3 4385.4 4389.3 4687.6 4713.2 4714.1 4737.2 4747.5 4349.2 4376.2 4608.4 5057.7 5068.5 5299.5 5300.4 5321.0 5338.2 5362.7 5171.5 5183.2 5195.7 5195.7 5216.6 4695.7 4960.6 5004.0 5008.5 5013.0 3677.5 3693.1 3696.9 3705.8 3707.3 5069.5 5303.5 5317.9 5324.2 5344.3 5016.1 5046.3 5056.7 5110.5 5137.5 5147.4 5148.7 5201.5 5208.5 5235.9 4899.3 5087.5 5090.5 5103.7 5108.4 5207.2 5210.6 5210.7 5236.3 5239.5 5061.5 5089.6 5097.6 5119.4 5120.1 11:26:07 INFO - PROCESS | 17237 | 11:26:07 INFO - PROCESS | 17237 | [#5] yui.html Cycles:180 Average:17270.01 Median:23934.95 stddev:23954.05 (100.1%) stddev-sans-first:23988.80 11:26:07 INFO - PROCESS | 17237 | Values: 664.5 687.6 711.4 720.2 721.5 12692.0 13606.5 13614.3 13631.7 13639.0 13004.2 13099.1 13121.5 13145.6 13157.1 622.0 622.4 741.7 751.5 780.8 782.3 789.2 796.3 797.6 797.8 658.6 845.0 846.5 846.9 846.9 803.3 822.4 829.0 829.5 830.1 605.1 606.5 608.1 609.9 611.3 13016.0 13047.7 13083.1 13089.3 13094.9 12669.0 13034.5 13108.9 13112.1 13379.8 11716.0 11806.2 11833.5 12052.0 12429.5 4279.7 4322.3 4328.3 4334.5 4367.7 59732.7 60698.7 61043.7 61111.7 61207.4 10057.3 10247.5 10271.3 10275.8 10610.2 16993.6 17842.3 18516.9 18578.3 18583.4 6946.7 6954.1 7002.5 7008.1 7048.4 3776.3 3800.4 3847.7 3866.4 3901.7 2888.0 2986.0 2986.6 2987.3 2990.1 509.3 509.6 511.3 528.0 529.1 466.2 481.4 538.7 543.5 553.6 7751.3 7895.0 8063.9 8115.8 8329.1 452.3 479.6 479.8 521.8 576.3 3701.8 3944.1 3949.3 3994.9 4048.8 90987.1 91533.5 92320.5 92838.0 94736.0 79237.6 79355.6 80636.0 82824.6 83262.0 42845.0 69575.7 71518.3 71748.3 72098.3 7310.5 7361.0 7538.7 7628.2 7645.8 41201.4 41606.4 42350.4 43535.3 43771.8 52298.5 62759.0 63042.4 63539.0 64217.0 8940.9 9372.2 10863.9 11086.1 11794.1 12439.9 12450.8 12791.1 12989.0 13140.3 11918.6 11965.6 12675.8 12698.7 12930.1 12271.2 12357.1 12537.5 12696.6 13039.5 11830.0 12090.7 12119.2 12240.3 12449.7 10229.5 10425.4 10513.8 10672.8 10768.0 10563.5 10653.6 10759.9 10880.6 10886.0 11:26:07 INFO - PROCESS | 17237 | -------- Summary: end -------- 11:26:07 INFO - PROCESS | 17237 | 11:26:08 INFO - TEST-INFO | 17237: exit 0 11:26:08 INFO - TEST-OK | dromaeo_css | took 1120134ms 11:26:08 INFO - TEST-START | kraken 11:26:08 INFO - operating with platform_type : linux_ 11:26:08 INFO - Initialising browser for kraken test... 11:26:08 INFO - TEST-INFO | started process 17418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLooqmE/profile http://localhost:50281/getInfo.html) 11:26:12 INFO - PROCESS | 17418 | __metrics Screen width/height:1600/1200 11:26:12 INFO - PROCESS | 17418 | colorDepth:24 11:26:12 INFO - PROCESS | 17418 | Browser inner width/height: 1024/697 11:26:12 INFO - PROCESS | 17418 | __metrics 11:26:13 INFO - PROCESS | 17418 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:26:14 INFO - TEST-INFO | 17418: exit 0 11:26:14 INFO - Browser initialized. 11:26:14 INFO - Running cycle 1/1 for kraken test... 11:26:14 INFO - TEST-INFO | started process 17498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLooqmE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:26 INFO - PROCESS | 17498 | RSS: Main: 174981120 11:26:26 INFO - PROCESS | 17498 | 11:26:29 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50281/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:30 INFO - PROCESS | 17498 | RSS: Main: 234029056 11:26:30 INFO - PROCESS | 17498 | 11:26:33 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50281/tests/kraken/driver.html?testName=audio-dft) 11:26:33 INFO - PROCESS | 17498 | RSS: Main: 221761536 11:26:33 INFO - PROCESS | 17498 | 11:26:36 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50281/tests/kraken/driver.html?testName=audio-fft) 11:26:37 INFO - PROCESS | 17498 | RSS: Main: 288575488 11:26:37 INFO - PROCESS | 17498 | 11:26:39 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50281/tests/kraken/driver.html?testName=audio-oscillator) 11:26:40 INFO - PROCESS | 17498 | RSS: Main: 199487488 11:26:40 INFO - PROCESS | 17498 | 11:26:42 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:43 INFO - PROCESS | 17498 | RSS: Main: 203120640 11:26:43 INFO - PROCESS | 17498 | 11:26:46 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50281/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:46 INFO - PROCESS | 17498 | RSS: Main: 239144960 11:26:46 INFO - PROCESS | 17498 | 11:26:50 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50281/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:51 INFO - PROCESS | 17498 | RSS: Main: 240025600 11:26:51 INFO - PROCESS | 17498 | 11:26:53 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50281/tests/kraken/driver.html?testName=json-parse-financial) 11:26:54 INFO - PROCESS | 17498 | RSS: Main: 240070656 11:26:54 INFO - PROCESS | 17498 | 11:26:56 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:56 INFO - PROCESS | 17498 | RSS: Main: 225595392 11:26:56 INFO - PROCESS | 17498 | 11:26:58 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:59 INFO - PROCESS | 17498 | RSS: Main: 231182336 11:26:59 INFO - PROCESS | 17498 | 11:27:01 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:02 INFO - PROCESS | 17498 | RSS: Main: 239521792 11:27:02 INFO - PROCESS | 17498 | 11:27:05 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:05 INFO - PROCESS | 17498 | RSS: Main: 241721344 11:27:05 INFO - PROCESS | 17498 | 11:27:08 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:09 INFO - PROCESS | 17498 | RSS: Main: 241238016 11:27:09 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | Cycle 1(1): loaded http://localhost:50281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50281/tests/kraken/driver.html?testName=ai-astar) 11:27:11 INFO - PROCESS | 17498 | RSS: Main: 283877376 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | __start_tp_report 11:27:11 INFO - PROCESS | 17498 | _x_x_mozilla_page_load 11:27:11 INFO - PROCESS | 17498 | _x_x_mozilla_page_load_details 11:27:11 INFO - PROCESS | 17498 | |i|pagename|runs| 11:27:11 INFO - PROCESS | 17498 | |0;ai-astar;113;109;113;115;111;112;111;111;112;112 11:27:11 INFO - PROCESS | 17498 | |1;audio-beat-detection;166;134;140;189;136;164;163;133;191;132 11:27:11 INFO - PROCESS | 17498 | |2;audio-dft;161;161;162;162;161;163;160;161;161;161 11:27:11 INFO - PROCESS | 17498 | |3;audio-fft;75;76;76;106;76;77;75;75;103;76 11:27:11 INFO - PROCESS | 17498 | |4;audio-oscillator;86;86;123;87;87;87;111;88;87;123 11:27:11 INFO - PROCESS | 17498 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 11:27:11 INFO - PROCESS | 17498 | |6;imaging-darkroom;147;145;146;146;145;145;146;146;146;147 11:27:11 INFO - PROCESS | 17498 | |7;imaging-desaturate;95;95;95;94;94;95;94;95;95;95 11:27:11 INFO - PROCESS | 17498 | |8;json-parse-financial;64;63;62;62;64;64;63;63;62;62 11:27:11 INFO - PROCESS | 17498 | |9;json-stringify-tinderbox;65;65;66;65;66;66;65;65;67;71 11:27:11 INFO - PROCESS | 17498 | |10;stanford-crypto-aes;90;86;83;83;86;90;85;87;124;83 11:27:11 INFO - PROCESS | 17498 | |11;stanford-crypto-ccm;152;134;131;150;134;133;137;133;136;131 11:27:11 INFO - PROCESS | 17498 | |12;stanford-crypto-pbkdf2;177;176;174;171;170;168;170;169;167;168 11:27:11 INFO - PROCESS | 17498 | |13;stanford-crypto-sha256-iterative;67;67;73;66;66;65;67;66;67;69 11:27:11 INFO - PROCESS | 17498 | __end_tp_report 11:27:11 INFO - PROCESS | 17498 | __start_cc_report 11:27:11 INFO - PROCESS | 17498 | _x_x_mozilla_cycle_collect,1930 11:27:11 INFO - PROCESS | 17498 | __end_cc_report 11:27:11 INFO - PROCESS | 17498 | __startTimestamp1466101631271__endTimestamp 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | ------- Summary: start ------- 11:27:11 INFO - PROCESS | 17498 | Number of tests: 14 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.60 (1.4%) stddev-sans-first:1.64 11:27:11 INFO - PROCESS | 17498 | Values: 113.0 109.0 113.0 115.0 111.0 112.0 111.0 111.0 112.0 112.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:163.50 stddev:22.99 (14.1%) stddev-sans-first:24.03 11:27:11 INFO - PROCESS | 17498 | Values: 166.0 134.0 140.0 189.0 136.0 164.0 163.0 133.0 191.0 132.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 11:27:11 INFO - PROCESS | 17498 | Values: 161.0 161.0 162.0 162.0 161.0 163.0 160.0 161.0 161.0 161.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:12.16 (16.0%) stddev-sans-first:12.67 11:27:11 INFO - PROCESS | 17498 | Values: 75.0 76.0 76.0 106.0 76.0 77.0 75.0 75.0 103.0 76.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:87.00 stddev:15.88 (18.2%) stddev-sans-first:16.38 11:27:11 INFO - PROCESS | 17498 | Values: 86.0 86.0 123.0 87.0 87.0 87.0 111.0 88.0 87.0 123.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:27:11 INFO - PROCESS | 17498 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 11:27:11 INFO - PROCESS | 17498 | Values: 147.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 147.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:27:11 INFO - PROCESS | 17498 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.83 11:27:11 INFO - PROCESS | 17498 | Values: 64.0 63.0 62.0 62.0 64.0 64.0 63.0 63.0 62.0 62.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.85 (2.8%) stddev-sans-first:1.92 11:27:11 INFO - PROCESS | 17498 | Values: 65.0 65.0 66.0 65.0 66.0 66.0 65.0 65.0 67.0 71.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:86.00 stddev:12.33 (14.3%) stddev-sans-first:13.08 11:27:11 INFO - PROCESS | 17498 | Values: 90.0 86.0 83.0 83.0 86.0 90.0 85.0 87.0 124.0 83.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:135.00 stddev:7.58 (5.6%) stddev-sans-first:5.81 11:27:11 INFO - PROCESS | 17498 | Values: 152.0 134.0 131.0 150.0 134.0 133.0 137.0 133.0 136.0 131.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:170.50 stddev:3.50 (2.1%) stddev-sans-first:2.96 11:27:11 INFO - PROCESS | 17498 | Values: 177.0 176.0 174.0 171.0 170.0 168.0 170.0 169.0 167.0 168.0 11:27:11 INFO - PROCESS | 17498 | 11:27:11 INFO - PROCESS | 17498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.26 (3.4%) stddev-sans-first:2.40 11:27:11 INFO - PROCESS | 17498 | Values: 67.0 67.0 73.0 66.0 66.0 65.0 67.0 66.0 67.0 69.0 11:27:11 INFO - PROCESS | 17498 | -------- Summary: end -------- 11:27:11 INFO - PROCESS | 17498 | 11:27:12 INFO - TEST-INFO | 17498: exit 0 11:27:12 INFO - TEST-OK | kraken | took 63981ms 11:27:12 INFO - SUITE-END | took 1184s 11:27:12 INFO - Completed test suite (00:19:44) 11:27:12 INFO - javascript benchmark 11:27:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.577507598784, 2642.260167153198, 2684.9328766780827, 2696.7707744841673, 2701.1896431070672, 4581.381513495677, 4653.813847446098, 4765.547273009063, 4783.617310615146, 4849.393825771778, 4723.645726570512, 4730.219513780231, 4735.3133795599615, 4787.0, 4790.305405716169, 4309.0735491869245, 4393.1213757248515, 4411.6250118739945, 4434.224010798113, 4564.018735971766, 4451.421315229016, 4469.217886869801, 4513.435820522434, 4525.0, 4543.204939135655, 4285.164392943378, 4330.870073897788, 4344.304911214191, 4371.038371558252, 4382.802773875183, 4290.978545107255, 4305.289627211507, 4343.609075183217, 4367.3667318238995, 4373.606375426195, 4322.589354011364, 4330.285502892019, 4344.500382456026, 4378.759168245745, 4378.759168245745, 4584.977075114636, 4698.600618947394, 4749.311349854252, 4757.690750101232, 4823.638227132979, 5147.536721695065, 5148.2020286855595, 5167.0957582422925, 5167.431582525919, 5188.92216616751, 5010.3737032870895, 5142.640015198937, 5213.608979326527, 5230.189320655267, 5234.633575649668, 4756.714597124149, 4794.640401969797, 4799.448063472745, 4811.927821082687, 4859.684120532154, 5281.9207711884355, 5288.3918349390315, 5303.04545181871, 5303.973480132575, 5318.095923692981, 4938.827141050046, 5046.823361182341, 5055.51972562606, 5074.035933172685, 5120.462351453119, 5154.252633368141, 5160.974195129075, 5178.430372659004, 5185.766640501187, 5231.346081739783, 5093.617978651616, 5107.974460127675, 5110.770015349318, 5136.717480538607, 5160.40655324635, 4932.1122198004705, 5013.222950442687, 5054.317667114966, 5099.464556221617, 5106.234064890222, 4301.720388174821, 4317.222899877989, 4324.870253892388, 4362.956370436318, 4367.5632436756705, 3753.6997040236715, 3777.0, 3778.301014312306, 3814.904627384282, 3821.0, 4320.848770293024, 4370.868873933787, 4388.583084607021, 4401.515833258339, 4415.580519850609, 5155.149400348975, 5177.223416487482, 5189.247559103909, 5191.636585439059, 5226.111561034633, 4417.60241578253, 4423.1153769246275, 4425.09285596452, 4457.3091170868565, 4472.955270447319, 4485.327200919888, 4615.30770384445, 4620.283856002325, 4646.976765116153, 4655.3947986761505, 4861.392325959255, 4868.2210846264425, 4876.926846097312, 4886.780094895667, 4913.140200464976, 5208.557272631869, 5231.947680523146, 5232.9738351308, 5234.764435600331, 5235.895282094413, 4707.6704630676895, 4796.688215265996, 4835.032993401404, 4846.055019271349, 4873.049755297683, 5049.873753156054, 5066.341375621146, 5073.315102461268, 5085.389753229636, 5125.564327032244, 5034.773435195351, 5148.922766158586, 5187.377514698261, 5189.4032186297545, 5191.844244672666, 4962.975185124052, 4975.825846095369, 4978.2781496682055, 4985.077760614298, 5003.299538064746, 5007.724575148256, 5017.247412888096, 5021.096202683552, 5021.6735912165595, 5069.518395752398, 4780.521947805191, 4843.321934929183, 4893.143699852582, 4902.1911384621135, 4972.0801651694555, 5012.223105418666, 5021.6484846061885, 5037.219231019198, 5047.444781074152, 5090.211017292326, 4910.410750709938, 4913.091078150554, 4916.262560615936, 4931.827386041615, 4993.101241776515], "value": 4706.3877971134425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.6725915339526, 574.4198359656747, 590.8759160576279, 602.3494625804132, 611.1413464082963, 28557.143285701437, 31629.84185079077, 31697.36605267893, 31855.52216716745, 32049.0, 31877.36245275093, 32279.51580726285, 40244.597554024454, 41255.38116928248, 41653.0, 7791.961040194805, 7901.367890568741, 7902.170272121431, 7918.089419716749, 7920.366370690331, 7738.61306934651, 7743.264389882952, 7805.60971951403, 7823.608819559027, 7831.41264405169, 7668.769936901902, 7864.882026769603, 7868.921310786876, 8074.919250807476, 9946.353487023356, 9743.464109473976, 10137.847932281022, 10150.746231344201, 10162.136218421443, 10169.033941775482, 10041.096301332915, 10137.89862101377, 10149.543270552844, 10155.28912976092, 10156.746081347952, 29613.259668508243, 38202.42696359529, 38804.61195388038, 39028.609713902784, 39360.21279574392, 2941.9264518387, 2964.019022362246, 3039.8024128431803, 3110.3623757129735, 3471.7743346682637, 29307.560386594218, 29672.25819354512, 29684.70315296841, 29856.253593660116, 32825.83587082073, 3300.5874265716784, 3477.6174620791694, 3585.8386372613295, 3615.8011309377976, 3630.818459077062, 259105.0, 260098.0, 260181.0, 260250.0, 261849.9999999981, 31889.681103189134, 32777.18057048593, 32831.50752738711, 34678.653213468046, 56104.438955610734, 33986.49020264698, 34021.489677654856, 34093.318133637185, 34128.0, 34172.14569635729, 12910.096293259381, 13039.674008149872, 13043.673908152372, 13053.804192937114, 13069.954403647685, 10654.89345106539, 10725.892741072645, 10810.0270975611, 10810.081143102925, 10820.35077895313, 7884.132745398002, 7908.090569584457, 7918.208179182036, 7975.641096150687, 7983.72056978003, 2889.0899366699423, 3075.169704179859, 3124.265797537577, 3124.703153200442, 3140.811551306929, 809.514291425152, 819.8729196974479, 908.8366890380191, 949.6343907595625, 989.737719504332, 26506.602400964002, 26636.843839555822, 27244.863775680995, 28523.286917826805, 28662.713372866423, 922.4834092907993, 944.617429940875, 972.8832540095092, 976.4336684722844, 1003.5333569890037, 14673.633159170893, 14878.553643390716, 14939.925300373428, 15152.0, 15262.236888155549, 408241.0, 413095.0, 413805.0, 413832.0, 414403.0, 43578.78210608927, 50069.24896126561, 50368.740781480024, 50395.74802125966, 50471.24293135606, 1126.7014241226082, 1151.6775302915198, 1157.1668398752884, 1158.206628459508, 1167.0197034491068, 28276.0, 28526.85736571304, 28826.59563303074, 29030.7096929028, 29132.27169320784, 43272.35091473693, 43630.0, 43944.56055439533, 44127.0, 44132.0, 368320.0, 374119.0, 393116.0, 557085.0, 571055.0, 37713.81143094267, 38763.80618096892, 38767.0, 38774.80612596919, 38785.2242955145, 42952.35571466493, 42987.0, 43054.35418468663, 43681.12637747291, 43906.56093439025, 36067.27865442729, 37090.62909370872, 37320.0, 37325.62674373222, 37615.2476950454, 35993.0, 36172.0, 36437.27125457529, 36685.63314366822, 36809.81595092115, 35630.28739425249, 35894.64105358913, 35920.0, 36850.0, 37776.0, 31883.681163188998, 33144.0, 33470.330593388484, 33546.83226583949, 34029.31941361209, 25658.61512077283, 25680.486390272465, 25689.229323120337, 25714.10000650043, 25903.0], "value": 16917.623436918628, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3406235806727, 367.8749225263411, 369.7116249325527, 378.7992364047054, 381.281284778193, 16283.185840707962, 16303.510894673163, 16996.915015424907, 17010.40463583775, 17030.48908532743, 14605.342759575818, 15178.848211517881, 15306.617334566641, 15355.462558810445, 15733.685326293467, 4919.557239848422, 5283.313169287987, 5283.498067683564, 5322.520973112419, 5332.306800115999, 3779.8866034019024, 3961.0, 5185.066687996159, 5867.589268751189, 6196.039613859859, 6205.22434695663, 6207.782727604535, 6231.937680623204, 6240.4071613196675, 6242.063690446424, 5947.286325640929, 6133.294671112834, 6140.969295153518, 6143.539234557426, 6150.753969841178, 3395.9830200848837, 5188.507091826271, 5391.622586418952, 5505.119180931072, 5515.751791169367, 17224.224909879085, 17235.91382043082, 17719.468415947413, 19730.112144953513, 19840.50398740043, 2075.3877606106234, 2205.4817117977263, 2217.013429024085, 2367.893444794971, 2535.8858851351547, 12779.424925878358, 12953.805692914613, 13109.0, 13125.60623181306, 13671.726565468634, 1734.8698847586356, 1795.2190797003345, 1843.1060935446299, 1852.7776666799934, 1859.981400186008, 58133.418665813224, 58492.0, 58577.70711146417, 60648.999999999556, 61077.0, 9036.367454278268, 9372.953135234417, 9611.134997850228, 9900.356476828983, 10456.163506919429, 13123.278219697817, 13226.867731322563, 13230.338483075808, 13232.13991090576, 13235.933820331029, 6949.7567585134275, 6987.406070483964, 7061.293870613001, 7081.716731330689, 7116.857662846817, 6598.901016484757, 6623.834404139839, 6795.252522222551, 6797.93202067973, 6798.592084474947, 5904.9704751475965, 6045.486133678599, 6123.234595675541, 6133.754649814046, 6207.441330280297, 1634.6648936967892, 1704.241612482458, 1759.9032053237195, 1782.1089455272363, 1792.7579776730236, 826.8181000179951, 842.1326034184799, 878.5255961780695, 886.5389997201419, 905.8867641544807, 16179.757303640456, 16571.91714041422, 16940.322387104377, 17072.658546828992, 18062.90968545149, 805.524740403165, 808.1514409869731, 858.9785255368665, 859.7721603774879, 901.2924853989717, 9310.72067837966, 9469.0, 9771.364861283993, 9824.312298139062, 9999.050090241415, 352438.0, 353097.0, 354019.0, 375570.0, 384957.0, 44555.55444445514, 59203.70398148068, 75460.24539754532, 75578.0, 78772.0, 871.7254064969641, 903.5301643145527, 908.2924102686907, 915.2860768600502, 917.4036876030633, 15640.765388519409, 15905.602359941095, 15905.840941590435, 15915.124668143364, 16164.272607732444, 25626.359341016625, 26870.865645672427, 35063.29873402569, 37583.43624845684, 37739.81130094332, 46383.0, 48339.274910877066, 52395.0, 52556.0, 53429.0, 6673.1324927761025, 7057.294270573107, 7145.142582889878, 7314.6708398121145, 7665.080190377191, 11596.88403115958, 11606.593769218036, 11961.162718609614, 12255.87744122583, 12296.569620063256, 10245.692629221136, 10442.68671939843, 10552.525136368728, 10606.204534659777, 10638.574457021632, 10388.37669739818, 10447.738806529898, 10522.31604945676, 10735.892641073802, 10753.46232688378, 10124.746881328027, 10205.183585313305, 10311.329763565343, 10668.466576671291, 10956.780864382508, 7083.433325334064, 7253.673584688807, 7267.236940121211, 7338.0, 7437.590932498764, 10556.313839600401, 10563.15494760402, 10580.788384232426, 10620.09729173029, 10639.095676867553], "value": 8243.339600910815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1219.8658147603767, 1386.542440994472, 1410.4428750643497, 1481.6592183797727, 1676.6562854614806, 6680.465562754974, 7668.0, 7906.841863162747, 7920.722774702886, 8142.674293028286, 7896.407769417288, 7999.0, 8073.878891816613, 8076.757697269091, 8080.272775450223, 2215.977840221601, 2247.4606094537357, 2249.640057590786, 2253.177590179589, 2253.661950707399, 2156.91372345106, 2158.84888057836, 2162.740471143457, 2163.3834357208198, 2222.122261706625, 2212.9557408851815, 2237.798598126168, 2243.921462748804, 2249.49386388063, 2250.426141333966, 2142.4215461825297, 2144.9356519304447, 2150.064721846002, 2150.1506904772605, 2151.806337429639, 2158.4711745622267, 2181.3564998325373, 2206.1396055538353, 2216.3240211735415, 2218.3234113595345, 7767.8446431071625, 8003.95998020012, 8058.11360750317, 8062.919370806276, 8065.39509536787, 4502.2121128802655, 4621.69958952667, 4634.443866735979, 4640.443146822403, 4647.093816705744, 2737.178846346088, 2799.440111977592, 2874.9937521867387, 2876.3384421583155, 2883.264767484299, 928.3037721708719, 934.9018353072897, 940.6519587752575, 942.0250041207386, 944.9149576538076, 10552.894471055268, 10629.202809789296, 10674.626388076458, 10682.732931676692, 10684.786304273872, 3969.861054863066, 4059.6143366380147, 4112.732672376286, 4147.605977432139, 4151.626353628188, 8461.407701460961, 8498.405111642125, 8502.489850608983, 8509.149085091442, 8517.659293628185, 4349.826006959749, 4387.802548885244, 4395.7142785718825, 4398.47218333802, 4399.6040356368085, 3563.1448452371765, 3992.7205095643026, 4032.334664780278, 4100.712950093465, 4132.690048246393, 3478.339115568034, 3481.8433170507387, 3565.625609311037, 3586.5875424326537, 3587.1390866191928, 1054.783769327286, 1073.4632683658172, 1083.669480808361, 1092.63396762084, 1092.7268182954263, 824.5382585751878, 825.2778818533783, 839.7480755773244, 841.9284360829398, 859.4499520307008, 5073.492650734897, 5169.896602067937, 5193.948060519422, 5293.523582877559, 5367.329083864517, 404.43177335842597, 414.3742948148318, 419.16795161604193, 420.42611834845826, 425.61694474972154, 3427.0, 3460.2041530448137, 3489.2149266415363, 3499.702525285379, 3585.15748799032, 9473.100055494717, 9810.362326448758, 9928.453935033642, 9959.0, 9975.052370024836, 9821.607135714634, 9833.557489912972, 9846.261530385249, 9849.50752462374, 9861.753456163653, 7251.782446526508, 7316.085489313836, 7416.22129676387, 7425.9628701856145, 7435.7769266921, 5070.442251352422, 5156.56169225605, 5165.896682066413, 5220.243064755665, 5243.921341179962, 8915.509646969478, 8956.865647015431, 9011.594478248626, 9112.362134650512, 9149.5882685278, 9073.954630226806, 9166.862497062417, 9170.495622740813, 9181.724548263563, 9456.810863782823, 5717.885642287214, 5819.738111785065, 5821.94178058231, 6536.7712130075215, 6612.173478315211, 7195.532290401107, 7264.237255088351, 7312.926870731225, 7552.320291173821, 7556.546607203585, 6930.410915072275, 7011.193712723102, 7062.8940565890525, 7155.964220179074, 7175.0, 6830.419414349836, 6834.794956151323, 6836.111305530249, 6981.7207311709, 7064.081669382947, 6457.128287681103, 6497.415232629086, 6502.3172566881685, 6505.381988711065, 6570.934290657032, 4463.107378524243, 4528.864134075983, 4561.49823519406, 4592.288195329729, 4636.235021221595, 4498.167838949805, 4514.367988481549, 4549.408576884984, 4550.977245113753, 4587.288970209623], "value": 4032.9300370670235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.85807096451776, 289.87680235899745, 296.20321335607207, 298.81473486438387, 300.05183619761556, 4733.337332773414, 4906.828261010865, 4918.581920536754, 4980.153373926432, 5013.473585273544, 4715.174844402224, 4827.251775974721, 4896.241082632188, 4900.779464924078, 4904.828331008415, 3875.8255878485393, 3876.759436980153, 3878.941815872764, 3880.2821478026513, 3883.631055049773, 3670.889873303792, 3742.569604495477, 3857.1514266861386, 3878.7672739635573, 3888.7083468739957, 3835.5780864104927, 3846.7114966377494, 3864.265789499986, 3864.3623802072625, 3875.8837234883, 3834.9041273968096, 3843.135294558716, 3854.7664747280883, 3856.8842934712, 3872.6514613684903, 3370.7808992415416, 3392.3724111039537, 3413.453847384407, 3421.1105112670884, 3421.349943510725, 4574.039451715111, 4720.834770783041, 4759.23852183649, 4767.976160119178, 4777.856664300077, 4249.277622804131, 4273.038566322583, 4289.2922667759785, 4290.2706539888295, 4305.203537345601, 5033.597312215051, 5076.213186956028, 5120.948790512121, 5133.974330128362, 5160.303359046518, 3607.8556857725657, 3691.187938653492, 3732.328180927432, 3734.9253014939823, 3749.3063783200196, 5314.60140489461, 5370.087085195487, 5383.67697938125, 5401.70290634015, 5407.404815579374, 3792.1657235408165, 3794.772313661189, 3838.3858582626644, 3850.0759817643566, 3850.152966347399, 3796.354619714655, 3867.535895692479, 3879.321118804198, 3884.9122245771227, 3893.201893611803, 4345.478542574911, 4376.3654270130655, 4378.5183629800695, 4379.1460665170625, 4390.8024138913825, 5124.282600435942, 5137.40919794221, 5156.458571849902, 5175.948240517622, 5178.818741344035, 1248.637895010455, 1293.4308904082175, 1311.7901135818224, 1312.2284915364373, 1319.630503459033, 817.8814071959532, 831.6548632317521, 835.3317346123077, 845.8139209373928, 853.4665833853842, 4030.717849750548, 4047.866597352746, 4055.8238110947495, 4058.188362327546, 4105.4252404663375, 4667.299905014207, 4674.275487299474, 4688.57802797743, 4717.386739723883, 4727.2436410174205, 4027.2146931348693, 4028.576999415078, 4031.455753473302, 4052.986753311672, 4061.2283666103344, 2330.8251881108986, 2453.889574969095, 2470.4564995700916, 2481.163938685396, 2495.2015355086196, 4312.137572485515, 4344.630706389929, 4377.343398490252, 4385.364122202327, 4389.344446609819, 4687.554682305175, 4713.198756211384, 4714.114354258256, 4737.2183589708, 4747.548982846693, 4349.216821103332, 4376.212281789309, 4608.400907881954, 5057.671251368723, 5068.467810879804, 5299.5230429261555, 5300.443453437333, 5320.962412329559, 5338.199270109515, 5362.65142765719, 5171.482851714798, 5183.222516622386, 5195.7142357170715, 5195.7142357170715, 5216.608754343363, 4695.718256904596, 4960.553550180501, 5004.048421115695, 5008.524190201925, 5012.974935125447, 3677.5035370224678, 3693.1136527233807, 3696.8706095286534, 3705.81470926458, 3707.295613833363, 5069.518395752398, 5303.515015795583, 5317.946820531745, 5324.1747529133045, 5344.331958505187, 5016.122178618654, 5046.29351890743, 5056.662602682212, 5110.540051395392, 5137.486251374833, 5147.433782283871, 5148.665336753099, 5201.453847346125, 5208.479152084761, 5235.895282094413, 4899.338589290543, 5087.54212120896, 5090.465501122477, 5103.724068982754, 5108.438071812172, 5207.192885102815, 5210.635255532076, 5210.6613070150315, 5236.293100431393, 5239.502247286502, 5061.4938506150565, 5089.592832573311, 5097.617678674188, 5119.436861945109, 5120.078385890575], "value": 3788.477050944824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.5082638847251, 687.5805758487325, 711.3988679565766, 720.229354590588, 721.5165838887945, 12692.0, 13606.455741770318, 13614.251216183105, 13631.727365452685, 13639.0, 13004.154729942571, 13099.148555343896, 13121.47514099435, 13145.60563183106, 13157.079004469691, 622.0296337713182, 622.3714048810712, 741.7366834773659, 751.5490705576665, 780.7657702689199, 782.284209947897, 789.2383849585149, 796.2952786783709, 797.5693125712138, 797.7606717984611, 658.6476235214161, 845.0239972831359, 846.4624963148384, 846.851800934837, 846.8729690546405, 803.2690251870798, 822.3708862720054, 829.0217543298905, 829.4857188543082, 830.1366578758084, 605.1195510532209, 606.4663096475118, 608.0544752909268, 609.9481544068759, 611.3122736920964, 13016.0, 13047.739045219138, 13083.149595276373, 13089.34553272342, 13094.869051309555, 12669.0, 13034.543790967271, 13108.934455327757, 13112.147710398793, 13379.799303010463, 11715.968671111426, 11806.23259488139, 11833.526658933632, 12052.0, 12429.502819887193, 4279.7218180818145, 4322.265214913441, 4328.329108988112, 4334.544872788375, 4367.716098453622, 59732.701336493476, 60698.69650651718, 61043.69478152581, 61111.69444152751, 61207.38792612062, 10057.29598928068, 10247.538860751136, 10271.332363396505, 10275.845862312071, 10610.20423468243, 16993.575160620836, 17842.286308547773, 18516.907415462836, 18578.349757758413, 18583.44249672512, 6946.652667366611, 6954.09596752429, 7002.474814388839, 7008.123984501937, 7048.436125109979, 3776.2825063237897, 3800.3729384651224, 3847.74989625679, 3866.420036994417, 3901.7463864848696, 2887.956680649792, 2985.9850700746792, 2986.566947792558, 2987.342784587387, 2990.1478078747455, 509.2691986998669, 509.5795968326072, 511.3046257090354, 528.0205219318186, 529.1242992846844, 466.2097744323339, 481.4343146802493, 538.68217751526, 543.4918351341508, 553.590343146069, 7751.342288577042, 7894.960525197337, 8063.919360806317, 8115.837683246302, 8329.125441828643, 452.29667866467304, 479.60672248755685, 479.8080767692951, 521.8382301486552, 576.3429690153229, 3701.759385639925, 3944.073142811437, 3949.3483575210344, 3994.9001274967777, 4048.7570745755347, 90987.09012909787, 91533.54233228925, 92320.53839730758, 92838.0, 94736.0, 79237.60381198057, 79355.60322198352, 80636.0, 82824.58587707144, 83262.0, 42845.0, 69575.65212173907, 71518.28481715116, 71748.2825171752, 72098.27901720916, 7310.451716121206, 7361.0, 7538.698452061856, 7628.199039100815, 7645.808854778675, 41201.38197926973, 41606.37590436207, 42350.36474452824, 43535.346969794846, 43771.78114109409, 52298.477015229364, 62759.0, 63042.36957630365, 63539.0, 64217.0, 8940.910590894007, 9372.203362713974, 10863.945680271549, 11086.057685096857, 11794.05647548177, 12439.875601243872, 12450.75098498043, 12791.104622676696, 12989.0, 13140.27728474943, 11918.642440726791, 11965.641030769091, 12675.80986285188, 12698.682532936751, 12930.071353734938, 12271.202371846159, 12357.135000550235, 12537.498500059895, 12696.555620553236, 13039.47842086344, 11830.036194159558, 12090.725175092604, 12119.212251203644, 12240.331108778711, 12449.688757780765, 10229.539670714687, 10425.374477531372, 10513.789724205626, 10672.83990740155, 10768.0, 10563.524641391003, 10653.627123050655, 10759.946200268949, 10880.564777408816, 10886.0], "value": 6562.730301078784, "unit": "score"}], "name": "dromaeo_css", "value": 6354.160759437915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 113.0, 115.0, 111.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 134.0, 140.0, 189.0, 136.0, 164.0, 163.0, 133.0, 191.0, 132.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 163.0, 160.0, 161.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 106.0, 76.0, 77.0, 75.0, 75.0, 103.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 123.0, 87.0, 87.0, 87.0, 111.0, 88.0, 87.0, 123.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 64.0, 64.0, 63.0, 63.0, 62.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 67.0, 71.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 83.0, 83.0, 86.0, 90.0, 85.0, 87.0, 124.0, 83.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 134.0, 131.0, 150.0, 134.0, 133.0, 137.0, 133.0, 136.0, 131.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 174.0, 171.0, 170.0, 168.0, 170.0, 169.0, 167.0, 168.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 73.0, 66.0, 66.0, 65.0, 67.0, 66.0, 67.0, 69.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1557.6999999999998, "alertThreshold": 2.0}]} 11:27:12 INFO - Return code: 0 11:27:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:27:12 INFO - # TBPL SUCCESS # 11:27:12 INFO - Running post-action listener: _resource_record_post_action 11:27:12 INFO - ##### 11:27:12 INFO - ##### Finished run-tests step (success) 11:27:12 INFO - ##### 11:27:12 INFO - Running post-run listener: _resource_record_post_run 11:27:12 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 371372032; Read time: 12; Write time: 232036 11:27:12 INFO - TinderboxPrint: CPU usage
13.2% 11:27:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:27:12 INFO - TinderboxPrint: I/O write bytes / time
371,372,032 / 232,036 11:27:12 INFO - TinderboxPrint: CPU idle
8,318.7 (86.8%) 11:27:12 INFO - TinderboxPrint: CPU user
1,219.7 (12.7%) 11:27:12 INFO - TinderboxPrint: Swap in / out
0 / 0 11:27:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 74289152; Read time: 0; Write time: 34828 11:27:12 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286838784; Read time: 12; Write time: 175220 11:27:13 INFO - Running post-run listener: _upload_blobber_files 11:27:13 INFO - Blob upload gear active. 11:27:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:13 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 11:27:13 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:13 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:27:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:14 INFO - (blobuploader) - INFO - Done attempting. 11:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:17 INFO - (blobuploader) - INFO - Done attempting. 11:27:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:27:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:27:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:18 INFO - (blobuploader) - INFO - Done attempting. 11:27:18 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:18 INFO - Return code: 0 11:27:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0333d15a5e11712008a79f3e002fb47ecbc2e32f03cbfca812cffcaebfd82e876c2308b36a9f3d87c290c6f5c0cf8da6cbab82d0521785b7913c40e7dd6e6df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e9a70b4723d8d4dbfbd58e6e9b449c8ebea88afc430543eda4db4e39af13724a23ff02a567b7508bf83845b8f905d0bf69ab7e32d96d07401b7a6315e8a6a270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10de9ffeb3e593f0ceba05be665ea8dc0bed50de3d78c23c4d1590c21062dc4aec45861401d71eccd263b36acb2b911067220772ce17097a6fc6df3880c31bd7"} 11:27:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:18 INFO - Contents: 11:27:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0333d15a5e11712008a79f3e002fb47ecbc2e32f03cbfca812cffcaebfd82e876c2308b36a9f3d87c290c6f5c0cf8da6cbab82d0521785b7913c40e7dd6e6df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e9a70b4723d8d4dbfbd58e6e9b449c8ebea88afc430543eda4db4e39af13724a23ff02a567b7508bf83845b8f905d0bf69ab7e32d96d07401b7a6315e8a6a270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10de9ffeb3e593f0ceba05be665ea8dc0bed50de3d78c23c4d1590c21062dc4aec45861401d71eccd263b36acb2b911067220772ce17097a6fc6df3880c31bd7"} 11:27:18 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:18 INFO - Copying logs to upload dir... 11:27:18 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.322904 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-16 11:27:18.127748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 11:27:18.130905) ========= 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=232498196343f89f466a4a9a000001c8-1466099607.43586-44492617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0333d15a5e11712008a79f3e002fb47ecbc2e32f03cbfca812cffcaebfd82e876c2308b36a9f3d87c290c6f5c0cf8da6cbab82d0521785b7913c40e7dd6e6df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e9a70b4723d8d4dbfbd58e6e9b449c8ebea88afc430543eda4db4e39af13724a23ff02a567b7508bf83845b8f905d0bf69ab7e32d96d07401b7a6315e8a6a270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10de9ffeb3e593f0ceba05be665ea8dc0bed50de3d78c23c4d1590c21062dc4aec45861401d71eccd263b36acb2b911067220772ce17097a6fc6df3880c31bd7"} build_url:https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011607 build_url: 'https://queue.taskcluster.net/v1/task/UbM7MAikRzGHj4SfwTbhFg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0333d15a5e11712008a79f3e002fb47ecbc2e32f03cbfca812cffcaebfd82e876c2308b36a9f3d87c290c6f5c0cf8da6cbab82d0521785b7913c40e7dd6e6df6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e9a70b4723d8d4dbfbd58e6e9b449c8ebea88afc430543eda4db4e39af13724a23ff02a567b7508bf83845b8f905d0bf69ab7e32d96d07401b7a6315e8a6a270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/10de9ffeb3e593f0ceba05be665ea8dc0bed50de3d78c23c4d1590c21062dc4aec45861401d71eccd263b36acb2b911067220772ce17097a6fc6df3880c31bd7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 11:27:18.155887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:27:18.156195) ========= 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=232498196343f89f466a4a9a000001c8-1466099607.43586-44492617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 11:27:18.239487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 11:27:18.239835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 11:27:18.240170) ========= ========= Total master_lag: 0.47 =========