builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1464989417.44 results: success (0) buildid: 20160603140228 builduid: 87d75f4d20b54058a4f3e8cbce35e7da revision: ab5e81678aaae8da42e11e8daf118e2a9c90baac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.437438) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.438301) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.438856) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.454384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.454716) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 14:30:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.9M=0s 2016-06-03 14:30:17 (59.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.391390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.862031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.862417) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019147 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.915651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:17.916049) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab5e81678aaae8da42e11e8daf118e2a9c90baac --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 ab5e81678aaae8da42e11e8daf118e2a9c90baac --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=20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 14:30:17,993 truncating revision to first 12 chars 2016-06-03 14:30:17,993 Setting DEBUG logging. 2016-06-03 14:30:17,993 attempt 1/10 2016-06-03 14:30:17,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab5e81678aaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 14:30:18,307 unpacking tar archive at: fx-team-ab5e81678aaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:18.626860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:18.627239) ========= script_repo_revision: ab5e81678aaae8da42e11e8daf118e2a9c90baac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:18.627744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:18.628063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:30:18.637897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-06-03 14:30:18.638236) ========= /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=20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:30:18 INFO - MultiFileLogger online at 20160603 14:30:18 in /builds/slave/test 14:30:18 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 14:30:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:30:18 INFO - {'append_to_log': False, 14:30:18 INFO - 'base_work_dir': '/builds/slave/test', 14:30:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:30:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:30:18 INFO - 'branch': 'Fx-Team-Non-PGO', 14:30:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:30:18 INFO - 'config_files': ('talos/linux_config.py',), 14:30:18 INFO - 'default_actions': ('clobber', 14:30:18 INFO - 'read-buildbot-config', 14:30:18 INFO - 'download-and-extract', 14:30:18 INFO - 'populate-webroot', 14:30:18 INFO - 'create-virtualenv', 14:30:18 INFO - 'install', 14:30:18 INFO - 'run-tests'), 14:30:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:30:18 INFO - 'download_minidump_stackwalk': True, 14:30:18 INFO - 'download_symbols': 'ondemand', 14:30:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:30:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:30:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:30:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:30:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:30:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:30:18 INFO - 'installer_path': 'installer.exe', 14:30:18 INFO - 'log_level': 'info', 14:30:18 INFO - 'log_name': 'talos', 14:30:18 INFO - 'log_to_console': True, 14:30:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:30:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:30:18 INFO - 'opt_config_files': (), 14:30:18 INFO - 'pip_index': False, 14:30:18 INFO - 'sps_profile': False, 14:30:18 INFO - 'sps_profile_interval': 0, 14:30:18 INFO - 'suite': 'dromaeojs', 14:30:18 INFO - 'system_bits': '32', 14:30:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:30:18 INFO - 'title': 'talos-linux64-ix-015', 14:30:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:30:18 INFO - 'use_talos_json': True, 14:30:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:30:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:30:18 INFO - 'work_dir': 'build'} 14:30:18 INFO - ##### 14:30:18 INFO - ##### Running clobber step. 14:30:18 INFO - ##### 14:30:18 INFO - Running pre-action listener: _resource_record_pre_action 14:30:18 INFO - Running main action method: clobber 14:30:18 INFO - rmtree: /builds/slave/test/build 14:30:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:30:19 INFO - Running post-action listener: _resource_record_post_action 14:30:19 INFO - ##### 14:30:19 INFO - ##### Finished clobber step (success) 14:30:19 INFO - ##### 14:30:19 INFO - ##### 14:30:19 INFO - ##### Running read-buildbot-config step. 14:30:19 INFO - ##### 14:30:19 INFO - Running pre-action listener: _resource_record_pre_action 14:30:19 INFO - Running main action method: read_buildbot_config 14:30:19 INFO - Using buildbot properties: 14:30:19 INFO - { 14:30:19 INFO - "project": "", 14:30:19 INFO - "product": "firefox", 14:30:19 INFO - "script_repo_revision": "production", 14:30:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:30:19 INFO - "repository": "", 14:30:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:30:19 INFO - "buildid": "20160603140228", 14:30:19 INFO - "pgo_build": "False", 14:30:19 INFO - "basedir": "/builds/slave/test", 14:30:19 INFO - "buildnumber": 3043, 14:30:19 INFO - "slavename": "talos-linux64-ix-015", 14:30:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:30:19 INFO - "platform": "ubuntu64_hw", 14:30:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:30:19 INFO - "branch": "fx-team", 14:30:19 INFO - "repo_path": "integration/fx-team", 14:30:19 INFO - "revision": "ab5e81678aaae8da42e11e8daf118e2a9c90baac", 14:30:19 INFO - "stage_platform": "linux64", 14:30:19 INFO - "builduid": "87d75f4d20b54058a4f3e8cbce35e7da", 14:30:19 INFO - "slavebuilddir": "test" 14:30:19 INFO - } 14:30:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:30:19 INFO - Running post-action listener: _resource_record_post_action 14:30:19 INFO - ##### 14:30:19 INFO - ##### Finished read-buildbot-config step (success) 14:30:19 INFO - ##### 14:30:19 INFO - ##### 14:30:19 INFO - ##### Running download-and-extract step. 14:30:19 INFO - ##### 14:30:19 INFO - Running pre-action listener: _resource_record_pre_action 14:30:19 INFO - Running main action method: download_and_extract 14:30:19 INFO - mkdir: /builds/slave/test/build/tests 14:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:19 INFO - https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:30:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:30:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:30:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:30:19 INFO - Downloaded 1361 bytes. 14:30:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:30:19 INFO - Using the following test package requirements: 14:30:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:30:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:30:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'jsshell-linux-x86_64.zip'], 14:30:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:30:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:30:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:30:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:30:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:30:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:30:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:30:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:19 INFO - https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:55 INFO - Downloaded 22868598 bytes. 14:30:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:30:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:30:56 INFO - Return code: 0 14:30:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:56 INFO - https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:30:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:30:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:30:58 INFO - Downloaded 22868598 bytes. 14:30:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:30:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:00 INFO - Return code: 0 14:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:00 INFO - https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:31:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:31:01 INFO - Downloaded 10833369 bytes. 14:31:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:31:01 INFO - Return code: 0 14:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:01 INFO - https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:31:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:31:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:31:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:31:02 INFO - Downloaded 55179184 bytes. 14:31:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:31:02 INFO - mkdir: /builds/slave/test/properties 14:31:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:02 INFO - Contents: 14:31:02 INFO - build_url:https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:31:03 INFO - Running post-action listener: _resource_record_post_action 14:31:03 INFO - Running post-action listener: set_extra_try_arguments 14:31:03 INFO - ##### 14:31:03 INFO - ##### Finished download-and-extract step (success) 14:31:03 INFO - ##### 14:31:03 INFO - ##### 14:31:03 INFO - ##### Running populate-webroot step. 14:31:03 INFO - ##### 14:31:03 INFO - Running pre-action listener: _resource_record_pre_action 14:31:03 INFO - Running main action method: populate_webroot 14:31:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:03 INFO - '--tppagecycles', 14:31:03 INFO - '7'], 14:31:03 INFO - 'tests': ['tsvgm']}}, 14:31:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['damp', 'tps']}, 14:31:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'tests': ['damp', 'tps']}, 14:31:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['dromaeo_dom']}, 14:31:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['a11yr', 14:31:03 INFO - 'ts_paint', 14:31:03 INFO - 'tpaint', 14:31:03 INFO - 'sessionrestore', 14:31:03 INFO - 'sessionrestore_no_auto_restore', 14:31:03 INFO - 'tabpaint']}, 14:31:03 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:03 INFO - 'ts_paint', 14:31:03 INFO - 'tpaint', 14:31:03 INFO - 'sessionrestore', 14:31:03 INFO - 'sessionrestore_no_auto_restore', 14:31:03 INFO - 'tabpaint']}, 14:31:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:31:03 INFO - 'ts_paint', 14:31:03 INFO - 'tpaint', 14:31:03 INFO - 'sessionrestore', 14:31:03 INFO - 'sessionrestore_no_auto_restore', 14:31:03 INFO - 'tabpaint']}, 14:31:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:31:03 INFO - 'ts_paint', 14:31:03 INFO - 'tpaint', 14:31:03 INFO - 'sessionrestore', 14:31:03 INFO - 'sessionrestore_no_auto_restore', 14:31:03 INFO - 'tabpaint']}, 14:31:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['a11yr', 14:31:03 INFO - 'ts_paint', 14:31:03 INFO - 'tpaint', 14:31:03 INFO - 'sessionrestore', 14:31:03 INFO - 'sessionrestore_no_auto_restore', 14:31:03 INFO - 'tabpaint']}, 14:31:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['a11yr', 14:31:03 INFO - 'ts_paint', 14:31:03 INFO - 'tpaint', 14:31:03 INFO - 'sessionrestore', 14:31:03 INFO - 'sessionrestore_no_auto_restore', 14:31:03 INFO - 'tabpaint']}, 14:31:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['tsvgx', 14:31:03 INFO - 'tsvgr_opacity', 14:31:03 INFO - 'tart', 14:31:03 INFO - 'tscrollx', 14:31:03 INFO - 'cart']}, 14:31:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:03 INFO - 'tsvgr_opacity', 14:31:03 INFO - 'tart', 14:31:03 INFO - 'tscrollx', 14:31:03 INFO - 'cart']}, 14:31:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'talos_options': ['--disable-e10s'], 14:31:03 INFO - 'tests': ['tp5o']}, 14:31:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'tests': ['tp5o']}, 14:31:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'talos_options': ['--disable-e10s', 14:31:03 INFO - '--xperf_path', 14:31:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:03 INFO - 'tests': ['tp5n']}, 14:31:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:03 INFO - 'talos_options': ['--xperf_path', 14:31:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:03 INFO - 'tests': ['tp5n']}}, 14:31:03 INFO - 'talos.zip': {'path': '', 14:31:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:03 INFO - Running post-action listener: _resource_record_post_action 14:31:03 INFO - ##### 14:31:03 INFO - ##### Finished populate-webroot step (success) 14:31:03 INFO - ##### 14:31:03 INFO - ##### 14:31:03 INFO - ##### Running create-virtualenv step. 14:31:03 INFO - ##### 14:31:03 INFO - Running pre-action listener: _resource_record_pre_action 14:31:03 INFO - Running main action method: create_virtualenv 14:31:03 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:31:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:03 INFO - Using real prefix '/usr' 14:31:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:04 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:06 INFO - Installing pip.................done. 14:31:06 INFO - Return code: 0 14:31:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31: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', 'pip>=1.5'] in /builds/slave/test/build 14:31: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 pip>=1.5 14:31:06 INFO - Using env: {'DISPLAY': ':0', 14:31:06 INFO - 'HOME': '/home/cltbld', 14:31:06 INFO - 'LANG': 'en_US.UTF-8', 14:31:06 INFO - 'LANGUAGE': 'en_US:en', 14:31:06 INFO - 'LOGNAME': 'cltbld', 14:31:06 INFO - 'MAIL': '/var/mail/cltbld', 14:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:06 INFO - 'MOZ_NO_REMOTE': '1', 14:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:06 INFO - 'NO_EM_RESTART': '1', 14:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:06 INFO - 'PWD': '/builds/slave/test', 14:31:06 INFO - 'SHELL': '/bin/bash', 14:31:06 INFO - 'SHLVL': '1', 14:31:06 INFO - 'TERM': 'linux', 14:31:06 INFO - 'TMOUT': '86400', 14:31:06 INFO - 'USER': 'cltbld', 14:31:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:06 INFO - '_': '/tools/buildbot/bin/python'} 14:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:31:06 INFO - Cleaning up... 14:31:06 INFO - Return code: 0 14:31:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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', '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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:31: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 psutil>=3.1.1 14:31:06 INFO - Using env: {'DISPLAY': ':0', 14:31:06 INFO - 'HOME': '/home/cltbld', 14:31:06 INFO - 'LANG': 'en_US.UTF-8', 14:31:06 INFO - 'LANGUAGE': 'en_US:en', 14:31:06 INFO - 'LOGNAME': 'cltbld', 14:31:06 INFO - 'MAIL': '/var/mail/cltbld', 14:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:06 INFO - 'MOZ_NO_REMOTE': '1', 14:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:06 INFO - 'NO_EM_RESTART': '1', 14:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:06 INFO - 'PWD': '/builds/slave/test', 14:31:06 INFO - 'SHELL': '/bin/bash', 14:31:06 INFO - 'SHLVL': '1', 14:31:06 INFO - 'TERM': 'linux', 14:31:06 INFO - 'TMOUT': '86400', 14:31:06 INFO - 'USER': 'cltbld', 14:31:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:06 INFO - '_': '/tools/buildbot/bin/python'} 14:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:06 INFO - Downloading/unpacking psutil>=3.1.1 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:08 INFO - Installing collected packages: psutil 14:31:08 INFO - Running setup.py install for psutil 14:31:08 INFO - building 'psutil._psutil_linux' extension 14:31:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:31:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:31:08 INFO - building 'psutil._psutil_posix' extension 14:31:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:31:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:09 INFO - Successfully installed psutil 14:31:09 INFO - Cleaning up... 14:31:09 INFO - Return code: 0 14:31:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:09 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:31:09 INFO - Using env: {'DISPLAY': ':0', 14:31:09 INFO - 'HOME': '/home/cltbld', 14:31:09 INFO - 'LANG': 'en_US.UTF-8', 14:31:09 INFO - 'LANGUAGE': 'en_US:en', 14:31:09 INFO - 'LOGNAME': 'cltbld', 14:31:09 INFO - 'MAIL': '/var/mail/cltbld', 14:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:09 INFO - 'MOZ_NO_REMOTE': '1', 14:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:09 INFO - 'NO_EM_RESTART': '1', 14:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:09 INFO - 'PWD': '/builds/slave/test', 14:31:09 INFO - 'SHELL': '/bin/bash', 14:31:09 INFO - 'SHLVL': '1', 14:31:09 INFO - 'TERM': 'linux', 14:31:09 INFO - 'TMOUT': '86400', 14:31:09 INFO - 'USER': 'cltbld', 14:31:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:09 INFO - '_': '/tools/buildbot/bin/python'} 14:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:31:11 INFO - Installing collected packages: mozsystemmonitor 14:31:11 INFO - Running setup.py install for mozsystemmonitor 14:31:11 INFO - Successfully installed mozsystemmonitor 14:31:11 INFO - Cleaning up... 14:31:11 INFO - Return code: 0 14:31:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:11 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:31:11 INFO - Using env: {'DISPLAY': ':0', 14:31:11 INFO - 'HOME': '/home/cltbld', 14:31:11 INFO - 'LANG': 'en_US.UTF-8', 14:31:11 INFO - 'LANGUAGE': 'en_US:en', 14:31:11 INFO - 'LOGNAME': 'cltbld', 14:31:11 INFO - 'MAIL': '/var/mail/cltbld', 14:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:11 INFO - 'MOZ_NO_REMOTE': '1', 14:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:11 INFO - 'NO_EM_RESTART': '1', 14:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:11 INFO - 'PWD': '/builds/slave/test', 14:31:11 INFO - 'SHELL': '/bin/bash', 14:31:11 INFO - 'SHLVL': '1', 14:31:11 INFO - 'TERM': 'linux', 14:31:11 INFO - 'TMOUT': '86400', 14:31:11 INFO - 'USER': 'cltbld', 14:31:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:11 INFO - '_': '/tools/buildbot/bin/python'} 14:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:11 INFO - Downloading/unpacking jsonschema==2.5.1 14:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:31:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:31:13 INFO - warning: no files found matching '*.txt' 14:31:13 INFO - no previously-included directories found matching 'build' 14:31:13 INFO - no previously-included directories found matching 'dist' 14:31:13 INFO - no previously-included directories found matching '.git*' 14:31:13 INFO - Installing collected packages: jsonschema, functools32 14:31:13 INFO - Running setup.py install for functools32 14:31:13 INFO - warning: no files found matching '*.txt' 14:31:13 INFO - no previously-included directories found matching 'build' 14:31:13 INFO - no previously-included directories found matching 'dist' 14:31:13 INFO - no previously-included directories found matching '.git*' 14:31:13 INFO - Successfully installed jsonschema functools32 14:31:13 INFO - Cleaning up... 14:31:13 INFO - Return code: 0 14:31:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:13 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:31:13 INFO - Using env: {'DISPLAY': ':0', 14:31:13 INFO - 'HOME': '/home/cltbld', 14:31:13 INFO - 'LANG': 'en_US.UTF-8', 14:31:13 INFO - 'LANGUAGE': 'en_US:en', 14:31:13 INFO - 'LOGNAME': 'cltbld', 14:31:13 INFO - 'MAIL': '/var/mail/cltbld', 14:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:13 INFO - 'MOZ_NO_REMOTE': '1', 14:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:13 INFO - 'NO_EM_RESTART': '1', 14:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:13 INFO - 'PWD': '/builds/slave/test', 14:31:13 INFO - 'SHELL': '/bin/bash', 14:31:13 INFO - 'SHLVL': '1', 14:31:13 INFO - 'TERM': 'linux', 14:31:13 INFO - 'TMOUT': '86400', 14:31:13 INFO - 'USER': 'cltbld', 14:31:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:13 INFO - '_': '/tools/buildbot/bin/python'} 14:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:14 INFO - Downloading/unpacking blobuploader==1.2.4 14:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:16 INFO - Downloading docopt-0.6.1.tar.gz 14:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:17 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:17 INFO - Running setup.py install for blobuploader 14:31:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:17 INFO - Running setup.py install for requests 14:31:17 INFO - Running setup.py install for docopt 14:31:17 INFO - Successfully installed blobuploader requests docopt 14:31:17 INFO - Cleaning up... 14:31:17 INFO - Return code: 0 14:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:17 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:17 INFO - Using env: {'DISPLAY': ':0', 14:31:17 INFO - 'HOME': '/home/cltbld', 14:31:17 INFO - 'LANG': 'en_US.UTF-8', 14:31:17 INFO - 'LANGUAGE': 'en_US:en', 14:31:17 INFO - 'LOGNAME': 'cltbld', 14:31:17 INFO - 'MAIL': '/var/mail/cltbld', 14:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:17 INFO - 'MOZ_NO_REMOTE': '1', 14:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:17 INFO - 'NO_EM_RESTART': '1', 14:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:17 INFO - 'PWD': '/builds/slave/test', 14:31:17 INFO - 'SHELL': '/bin/bash', 14:31:17 INFO - 'SHLVL': '1', 14:31:17 INFO - 'TERM': 'linux', 14:31:17 INFO - 'TMOUT': '86400', 14:31:17 INFO - 'USER': 'cltbld', 14:31:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:17 INFO - '_': '/tools/buildbot/bin/python'} 14:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:17 INFO - Running setup.py (path:/tmp/pip-TAOkTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:17 INFO - Running setup.py (path:/tmp/pip-1rxIxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:18 INFO - Running setup.py (path:/tmp/pip-T1b891-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:18 INFO - Running setup.py (path:/tmp/pip-de_not-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:18 INFO - Running setup.py (path:/tmp/pip-PZXvHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:18 INFO - Running setup.py (path:/tmp/pip-gR1gVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:18 INFO - Running setup.py (path:/tmp/pip-Wh2xCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:18 INFO - Running setup.py (path:/tmp/pip-cmDrTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:18 INFO - Running setup.py (path:/tmp/pip-ZE0rBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:18 INFO - Running setup.py (path:/tmp/pip-5H2Flw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:18 INFO - Running setup.py (path:/tmp/pip-_AaR4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:18 INFO - Running setup.py (path:/tmp/pip-4Ctfyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:18 INFO - Running setup.py (path:/tmp/pip-hsdtvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:18 INFO - Running setup.py (path:/tmp/pip-JNPUJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:18 INFO - Running setup.py (path:/tmp/pip-ldHqnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:18 INFO - Running setup.py (path:/tmp/pip-XfkURf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:19 INFO - Running setup.py (path:/tmp/pip-iaqqjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:19 INFO - Running setup.py install for manifestparser 14:31:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Running setup.py install for mozcrash 14:31:19 INFO - Running setup.py install for mozdebug 14:31:19 INFO - Running setup.py install for mozdevice 14:31:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Running setup.py install for mozfile 14:31:19 INFO - Running setup.py install for mozhttpd 14:31:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Running setup.py install for mozinfo 14:31:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Running setup.py install for mozInstall 14:31:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:19 INFO - Running setup.py install for mozleak 14:31:20 INFO - Running setup.py install for mozlog 14:31:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:20 INFO - Running setup.py install for moznetwork 14:31:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:20 INFO - Running setup.py install for mozprocess 14:31:20 INFO - Running setup.py install for mozprofile 14:31:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:20 INFO - Running setup.py install for mozrunner 14:31:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:20 INFO - Running setup.py install for mozscreenshot 14:31:20 INFO - Running setup.py install for moztest 14:31:20 INFO - Running setup.py install for mozversion 14:31:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:20 INFO - Cleaning up... 14:31:20 INFO - Return code: 0 14:31:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:20 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:20 INFO - Using env: {'DISPLAY': ':0', 14:31:20 INFO - 'HOME': '/home/cltbld', 14:31:20 INFO - 'LANG': 'en_US.UTF-8', 14:31:20 INFO - 'LANGUAGE': 'en_US:en', 14:31:20 INFO - 'LOGNAME': 'cltbld', 14:31:20 INFO - 'MAIL': '/var/mail/cltbld', 14:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:20 INFO - 'MOZ_NO_REMOTE': '1', 14:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:20 INFO - 'NO_EM_RESTART': '1', 14:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:20 INFO - 'PWD': '/builds/slave/test', 14:31:20 INFO - 'SHELL': '/bin/bash', 14:31:20 INFO - 'SHLVL': '1', 14:31:20 INFO - 'TERM': 'linux', 14:31:20 INFO - 'TMOUT': '86400', 14:31:20 INFO - 'USER': 'cltbld', 14:31:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:20 INFO - '_': '/tools/buildbot/bin/python'} 14:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:21 INFO - Running setup.py (path:/tmp/pip-zaiatE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:21 INFO - Running setup.py (path:/tmp/pip-6Pp8rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:21 INFO - Running setup.py (path:/tmp/pip-KKgFik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:21 INFO - Running setup.py (path:/tmp/pip-PfHwHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:21 INFO - Running setup.py (path:/tmp/pip-3MIXvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:21 INFO - Running setup.py (path:/tmp/pip-bHP6ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:21 INFO - Running setup.py (path:/tmp/pip-iIcwGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:21 INFO - Running setup.py (path:/tmp/pip-1weQ69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:21 INFO - Running setup.py (path:/tmp/pip-UytRuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:21 INFO - Running setup.py (path:/tmp/pip-qWSxsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:21 INFO - Running setup.py (path:/tmp/pip-m19ijc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:21 INFO - Running setup.py (path:/tmp/pip-3xQ90W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:21 INFO - Running setup.py (path:/tmp/pip-H08ODO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:22 INFO - Running setup.py (path:/tmp/pip-wDb7eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:22 INFO - Running setup.py (path:/tmp/pip-0sV_6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:22 INFO - Running setup.py (path:/tmp/pip-d6ZOOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:22 INFO - Running setup.py (path:/tmp/pip-Z6eHRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:31:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:24 INFO - Downloading blessings-1.6.tar.gz 14:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:24 INFO - Installing collected packages: blessings 14:31:24 INFO - Running setup.py install for blessings 14:31:24 INFO - Successfully installed blessings 14:31:24 INFO - Cleaning up... 14:31:24 INFO - Return code: 0 14:31:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:24 INFO - Reading from file tmpfile_stdout 14:31:24 INFO - Current package versions: 14:31:24 INFO - argparse == 1.2.1 14:31:24 INFO - blessings == 1.6 14:31:24 INFO - blobuploader == 1.2.4 14:31:24 INFO - docopt == 0.6.1 14:31:24 INFO - functools32 == 3.2.3-2 14:31:24 INFO - jsonschema == 2.5.1 14:31:24 INFO - manifestparser == 1.1 14:31:24 INFO - mozInstall == 1.12 14:31:24 INFO - mozcrash == 0.17 14:31:24 INFO - mozdebug == 0.1 14:31:24 INFO - mozdevice == 0.48 14:31:24 INFO - mozfile == 1.2 14:31:24 INFO - mozhttpd == 0.7 14:31:24 INFO - mozinfo == 0.9 14:31:24 INFO - mozleak == 0.1 14:31:24 INFO - mozlog == 3.2 14:31:24 INFO - moznetwork == 0.27 14:31:24 INFO - mozprocess == 0.22 14:31:24 INFO - mozprofile == 0.28 14:31:24 INFO - mozrunner == 6.11 14:31:24 INFO - mozscreenshot == 0.1 14:31:24 INFO - mozsystemmonitor == 0.3 14:31:24 INFO - moztest == 0.7 14:31:24 INFO - mozversion == 1.4 14:31:24 INFO - psutil == 3.1.1 14:31:24 INFO - requests == 1.2.3 14:31:24 INFO - wsgiref == 0.1.2 14:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:24 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:31:24 INFO - Using env: {'DISPLAY': ':0', 14:31:24 INFO - 'HOME': '/home/cltbld', 14:31:24 INFO - 'LANG': 'en_US.UTF-8', 14:31:24 INFO - 'LANGUAGE': 'en_US:en', 14:31:24 INFO - 'LOGNAME': 'cltbld', 14:31:24 INFO - 'MAIL': '/var/mail/cltbld', 14:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:24 INFO - 'MOZ_NO_REMOTE': '1', 14:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:24 INFO - 'NO_EM_RESTART': '1', 14:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:24 INFO - 'PWD': '/builds/slave/test', 14:31:24 INFO - 'SHELL': '/bin/bash', 14:31:24 INFO - 'SHLVL': '1', 14:31:24 INFO - 'TERM': 'linux', 14:31:24 INFO - 'TMOUT': '86400', 14:31:24 INFO - 'USER': 'cltbld', 14:31:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:24 INFO - '_': '/tools/buildbot/bin/python'} 14:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:31:24 INFO - Cleaning up... 14:31:24 INFO - Return code: 0 14:31:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:24 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:31:24 INFO - Using env: {'DISPLAY': ':0', 14:31:24 INFO - 'HOME': '/home/cltbld', 14:31:24 INFO - 'LANG': 'en_US.UTF-8', 14:31:24 INFO - 'LANGUAGE': 'en_US:en', 14:31:24 INFO - 'LOGNAME': 'cltbld', 14:31:24 INFO - 'MAIL': '/var/mail/cltbld', 14:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:24 INFO - 'MOZ_NO_REMOTE': '1', 14:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:24 INFO - 'NO_EM_RESTART': '1', 14:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:24 INFO - 'PWD': '/builds/slave/test', 14:31:24 INFO - 'SHELL': '/bin/bash', 14:31:24 INFO - 'SHLVL': '1', 14:31:24 INFO - 'TERM': 'linux', 14:31:24 INFO - 'TMOUT': '86400', 14:31:24 INFO - 'USER': 'cltbld', 14:31:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:24 INFO - '_': '/tools/buildbot/bin/python'} 14:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:31:25 INFO - Cleaning up... 14:31:25 INFO - Return code: 0 14:31:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:25 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 0x7fe6df88bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bae020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:31:25 INFO - Using env: {'DISPLAY': ':0', 14:31:25 INFO - 'HOME': '/home/cltbld', 14:31:25 INFO - 'LANG': 'en_US.UTF-8', 14:31:25 INFO - 'LANGUAGE': 'en_US:en', 14:31:25 INFO - 'LOGNAME': 'cltbld', 14:31:25 INFO - 'MAIL': '/var/mail/cltbld', 14:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:25 INFO - 'MOZ_NO_REMOTE': '1', 14:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:25 INFO - 'NO_EM_RESTART': '1', 14:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:25 INFO - 'PWD': '/builds/slave/test', 14:31:25 INFO - 'SHELL': '/bin/bash', 14:31:25 INFO - 'SHLVL': '1', 14:31:25 INFO - 'TERM': 'linux', 14:31:25 INFO - 'TMOUT': '86400', 14:31:25 INFO - 'USER': 'cltbld', 14:31:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:25 INFO - '_': '/tools/buildbot/bin/python'} 14:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:25 INFO - Downloading/unpacking flake8 14:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:31:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:31:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:31:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:27 INFO - no previously-included directories found matching 'docs/_build' 14:31:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:31:27 INFO - Running setup.py install for pep8 14:31:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:28 INFO - no previously-included directories found matching 'docs/_build' 14:31:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:31:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:31:28 INFO - Cleaning up... 14:31:28 INFO - Return code: 0 14:31:28 INFO - Running post-action listener: _resource_record_post_action 14:31:28 INFO - Running post-action listener: _start_resource_monitoring 14:31:28 INFO - Starting resource monitoring. 14:31:28 INFO - ##### 14:31:28 INFO - ##### Finished create-virtualenv step (success) 14:31:28 INFO - ##### 14:31:28 INFO - ##### 14:31:28 INFO - ##### Running install step. 14:31:28 INFO - ##### 14:31:28 INFO - Running pre-action listener: _resource_record_pre_action 14:31:28 INFO - Running main action method: install 14:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:28 INFO - Reading from file tmpfile_stdout 14:31:28 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:28 INFO - Reading from file tmpfile_stdout 14:31:28 INFO - Output received: 14:31:28 INFO - Usage: mozinstall [options] installer 14:31:28 INFO - Options: 14:31:28 INFO - -h, --help show this help message and exit 14:31:28 INFO - -d DEST, --destination=DEST 14:31:28 INFO - Directory to install application into. [default: 14:31:28 INFO - "/builds/slave/test"] 14:31:28 INFO - --app=APP Application being installed. [default: firefox] 14:31:28 INFO - mkdir: /builds/slave/test/build/application 14:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:31:44 INFO - Reading from file tmpfile_stdout 14:31:44 INFO - Output received: 14:31:44 INFO - /builds/slave/test/build/application/firefox/firefox 14:31:44 INFO - Running post-action listener: _resource_record_post_action 14:31:44 INFO - ##### 14:31:44 INFO - ##### Finished install step (success) 14:31:44 INFO - ##### 14:31:44 INFO - ##### 14:31:44 INFO - ##### Running run-tests step. 14:31:44 INFO - ##### 14:31:44 INFO - Running pre-action listener: _resource_record_pre_action 14:31:44 INFO - Running main action method: run_tests 14:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:31:44 INFO - Python 2.7.3 14:31:44 INFO - Return code: 0 14:31:44 INFO - grabbing minidump binary from tooltool 14:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:44 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 0x1c402e0>, '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 0x1bac140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bac5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:31:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:31:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:31:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:31:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:31:44 INFO - Return code: 0 14:31:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:31:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:31:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:31:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:31:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:31:45 INFO - Return code: 0 14:31:45 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/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 14:31:45 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/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 14:31:45 INFO - Using env: {'DISPLAY': ':0', 14:31:45 INFO - 'HOME': '/home/cltbld', 14:31:45 INFO - 'LANG': 'en_US.UTF-8', 14:31:45 INFO - 'LANGUAGE': 'en_US:en', 14:31:45 INFO - 'LOGNAME': 'cltbld', 14:31:45 INFO - 'MAIL': '/var/mail/cltbld', 14:31:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:31:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:45 INFO - 'MOZ_NO_REMOTE': '1', 14:31:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:45 INFO - 'NO_EM_RESTART': '1', 14:31:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:45 INFO - 'PWD': '/builds/slave/test', 14:31:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:31:45 INFO - 'SHELL': '/bin/bash', 14:31:45 INFO - 'SHLVL': '1', 14:31:45 INFO - 'TERM': 'linux', 14:31:45 INFO - 'TMOUT': '86400', 14:31:45 INFO - 'USER': 'cltbld', 14:31:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127', 14:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:45 INFO - '_': '/tools/buildbot/bin/python'} 14:31:45 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/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 14:31:45 INFO - mozversion application_buildid: 20160603140228 14:31:45 INFO - mozversion application_changeset: ab5e81678aaae8da42e11e8daf118e2a9c90baac 14:31:45 INFO - mozversion application_display_name: Nightly 14:31:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:31:45 INFO - mozversion application_name: Firefox 14:31:45 INFO - mozversion application_remotingname: firefox 14:31:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:31:45 INFO - mozversion application_vendor: Mozilla 14:31:45 INFO - mozversion application_version: 49.0a1 14:31:45 INFO - mozversion platform_buildid: 20160603140228 14:31:45 INFO - mozversion platform_changeset: ab5e81678aaae8da42e11e8daf118e2a9c90baac 14:31:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:31:45 INFO - mozversion platform_version: 49.0a1 14:31:45 INFO - using testdate: 1464989505 14:31:45 INFO - actual date: 1464989505 14:31:45 INFO - starting webserver on 'localhost:54498' 14:31:45 INFO - SUITE-START | Running 2 tests 14:31:45 INFO - TEST-START | dromaeo_css 14:31:45 INFO - operating with platform_type : linux_ 14:31:45 INFO - Initialising browser for dromaeo_css test... 14:31:45 INFO - TEST-INFO | started process 6224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxb1C2l/profile http://localhost:54498/getInfo.html) 14:31:49 INFO - PROCESS | 6224 | __metrics Screen width/height:1600/1200 14:31:49 INFO - PROCESS | 6224 | colorDepth:24 14:31:49 INFO - PROCESS | 6224 | Browser inner width/height: 1024/697 14:31:49 INFO - PROCESS | 6224 | __metrics 14:31:50 ERROR - PROCESS | 6224 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:31:51 INFO - TEST-INFO | 6224: exit 0 14:31:51 INFO - Browser initialized. 14:31:51 INFO - Running cycle 1/1 for dromaeo_css test... 14:31:51 INFO - TEST-INFO | started process 6308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxb1C2l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:03 INFO - PROCESS | 6308 | RSS: Main: 157532160 14:32:03 INFO - PROCESS | 6308 | 14:32:55 INFO - PROCESS | 6308 | 1464989575405 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:35:07 INFO - PROCESS | 6308 | Cycle 1(1): loaded http://localhost:54498/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54498/tests/dromaeo/cssquery-ext.html) 14:35:08 INFO - PROCESS | 6308 | RSS: Main: 244559872 14:35:08 INFO - PROCESS | 6308 | 14:38:10 INFO - PROCESS | 6308 | Cycle 1(1): loaded http://localhost:54498/tests/dromaeo/cssquery-ext.html (next: http://localhost:54498/tests/dromaeo/cssquery-jquery.html) 14:38:11 INFO - PROCESS | 6308 | RSS: Main: 239431680 14:38:11 INFO - PROCESS | 6308 | 14:41:13 INFO - PROCESS | 6308 | Cycle 1(1): loaded http://localhost:54498/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54498/tests/dromaeo/cssquery-mootools.html) 14:41:14 INFO - PROCESS | 6308 | RSS: Main: 240877568 14:41:14 INFO - PROCESS | 6308 | 14:44:16 INFO - PROCESS | 6308 | Cycle 1(1): loaded http://localhost:54498/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54498/tests/dromaeo/cssquery-prototype.html) 14:44:16 INFO - PROCESS | 6308 | RSS: Main: 240840704 14:44:16 INFO - PROCESS | 6308 | 14:47:20 INFO - PROCESS | 6308 | Cycle 1(1): loaded http://localhost:54498/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54498/tests/dromaeo/cssquery-yui.html) 14:47:20 INFO - PROCESS | 6308 | RSS: Main: 214556672 14:47:20 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | Cycle 1(1): loaded http://localhost:54498/tests/dromaeo/cssquery-yui.html (next: http://localhost:54498/tests/dromaeo/cssquery-dojo.html) 14:50:23 INFO - PROCESS | 6308 | RSS: Main: 290611200 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | __start_tp_report 14:50:23 INFO - PROCESS | 6308 | _x_x_mozilla_page_load 14:50:23 INFO - PROCESS | 6308 | _x_x_mozilla_page_load_details 14:50:23 INFO - PROCESS | 6308 | |i|pagename|runs| 14:50:23 INFO - PROCESS | 6308 | |0;dojo.html;2686.127008722166;2696.973030269697;2711.955896979663;2730.5221586222406;2745.341118131649;4588;4680.3447517347595;4709.481956984733;4715.717056976584;4795.017021510591;4706.858794236178;4726.0784147091335;4738.502457241992;4750.16872047392;4757.096151731169;4156.6051225133715;4319.805608747606;4384.539623339551;4434.135343607998;4527.547245275479;4434.778261086949;4477.597016268535;4487.977560112211;4492.573205545468;4523.638108951292;4262.701610887224;4313.1158112586845;4318.287482565404;4324.243257429968;4375.431193944767;4333.761643109628;4342.30523116303;4347.760873151976;4399.054203346264;4404.647628189737;4367.344898265285;4369.650427965755;4391.516933137353;4420.359047938063;4426.048399594103;4522.570355816192;4627.282771170474;4662.696924699883;4674.298855171717;4692.741899195543;5164.948350516484;5209.1404918188455;5219.373675159005;5227.451117632631;5232.03207406631;5176.974115129438;5228.660137091077;5228.738563071831;5233.031889100528;5247.2129180623215;4670.859874203746;4750.643701722384;4801.423829140525;4806.134895718735;4869.780859861315;5290.418054014055;5311.28297679816;5312.946870531323;5317.41508434072;5318.282031925718;4886.65793394459;5042.445331013586;5106.106431374495;5109.259157422153;5112.437631860493;5061.645684802103;5085.694858308513;5094.974525127351;5099.6685215460875;5109.335786347825;5047.41954675217;5048.974755126274;5054.393472783289;5057.291979122926;5104.464031276737;4906.55840974314;4951.653384263139;5019.247112933089;5034.395872495251;5035.496450355008;4255.340422234559;4267.871963841089;4270.29540125882;4304.225239456865;4319.589638984291;3720.5907350191455;3733.4586484959527;3736.850525978985;3762.078290818767;3772.038130276817;4225.260579398593;4249.936250956238;4258.510271318776;4348.608625223682;4350.195213885441;5003.974980125076;5064.594832413398;5093.032323858455;5099.69401835891;5124.846254612367;4355.934660980088;4380.802863871133;4390.143921935256;4390.495093064274;4440.200763862471;4440.62254708347;4603.355530225771;4610.2854057621125;4615.930761038587;4642.419697537808;4670.1126785910565;4701.059788042337;4743.5967942724565;4744.572988431058;4749.050189961952;5038.193888977746;5047.7476126192805;5049.141645920276;5084.949150508448;5121.206213036985;4838.250071238964;4840.443349014768;4880.438749543706;4884.194107972145;4888.95111048885;5059.822906198266;5060.8987820242655;5062.468440813809;5068.239764035424;5111.412187598474;4938.407391113089;5023.648344615842;5084.466131056186;5115.693058416507;5123.666961647481;4917.311576379238;4936.407631084293;4946.307516947702;5000.024995126061;5001.449840517467;4933.383327084114;4934.235193545006;4937.35814344133;4938.629602779734;4993.850184494471;4642.953570464252;4833.975830120827;4850.80596776125;4860.17377045896;4900.093482705711;5023.899522009612;5029.974850125726;5043.5460808527405;5050.217216331474;5117.974410127926;4890.24201248807;4902.607791376753;4905.386826646669;4906.092372911023;4939.975300123477 14:50:23 INFO - PROCESS | 6308 | |1;ext.html;563.5998441106814;597.4801922327574;598.8562744941215;618.3908849782964;622.2129006806391;28850.711492885064;39711.40432893505;40979.18041639165;41007.56473523431;41150.58849411512;41925.790371048104;42291.3656295155;42369.57630423702;42408;42440.78779606098;7483.4013278937555;7688.884666730003;7911.446198766089;7917.168697286788;9760.2679799015;9623.1820295275;10072.748181295454;10074.143697785661;10075.042870927251;10086.899131008706;9969.302148849583;10018.799624007515;10081.39511629301;10083.092521673048;10083.495825208747;9957.55191016406;10051.547680354402;10055.89944100557;10069.144122749574;10070.496475176213;9877.950610246902;9948.353357031841;9978.750531236705;9980.101790838788;9986.400815950994;38908.610913890785;39462.40806387906;39462.80268598667;39495;39517.60482395168;2928.2240206345336;3195.72836308914;3681.8159092045557;3726.1802403471193;3828.3874580067054;27490.0378486754;29798;29840.10479685591;30096.398072038657;31286.843565782252;3142.858571364294;3315.800252756078;3361.1765117546356;3467.6358982306747;3504.4743288506675;262921;264479;265109;265893;266407.6679616609;29806;30935.535966960513;57000.71499642475;57855;57886;33097.01417914885;33285.833570831994;33287.50068748971;33344.99965001054;33353.49969750456;12326.50693972231;12329.198602090835;12374.071944604011;12497.312647804276;12639.241645501299;9696.224302055818;9987.700368988943;10034.24743144267;10059.245556583286;10417.739556511147;7967.322777563972;7980.201979801974;8010.879836802453;8062.072861620872;8075.5558444286125;3087.073877836685;3101.7518598512065;3103.0845900459417;3126.765492588065;3146.7639927005566;914.8307563100715;952.5899474329956;954.627695198873;968.8498282766183;982.5922242269521;26191;27317;27516.862415687792;27921.16236512908;27932;945.3382632157517;952.7332346942867;963.8120566489467;975.1370037516849;1046.3198920701452;14520.346584403727;14817.333220005126;14917.850821491864;15148.091114532943;15177.848221517865;379064;381563;381614;384739;385818;48918;49452.50547494479;49455.75272123616;49498.25752613714;49526.257106143436;1077.0737166037202;1191.642507247822;1194.75507520958;1197.3713800254936;1238.4612693478366;27717.72282277232;29177.541122944192;29260.707392925797;29398.11805645834;29780;42863.78568107139;43404;43418.78290608527;43420.56579434165;43433;281217;288053;288150;288459;289421;22419.663705044764;24657.753422465546;25179.866905989642;25651.358716031504;27300.31749206286;41955.95110122149;43304.78347608242;43504;43761.490683229815;48329.75835120802;37282.81358593189;38262.23475530418;38584.2283154341;38989.8050509757;39055.41416878692;37222.25555488821;37267.254654907294;37510;37653.62346376611;37658.62341376551;36493.45259821052;36580.45129323009;36764.816175918946;36819.63180368162;37034.44448333331;32450.513242300913;33548;33841.49237761485;33853.3229335407;33858.3228335427;24702.641354724943;24723.134690285755;25010.65569708069;25271.36821579475;25301.367465813502 14:50:23 INFO - PROCESS | 6308 | |2;jquery.html;361.97828130312183;365.77322060322604;365.8481730082016;378.8314200180919;390.7245391998641;15680.52958411248;16792.83207167928;16905.323787048535;17196.82803171968;17399.130043497837;15227.619309517268;15290.770638440405;15338.846611533882;15391.230438478087;16081.356745730156;4938.925916111252;5126.897462050757;5134.537891589756;5165.096108181072;5168.948310516885;3752.9437058444146;3956.287868183726;5112.079825631404;5684.118961560965;6014.308354539218;6025.578209525335;6065.636061836304;6105.786297479589;6117.235345581802;6118.4799292060225;5844.26946631671;5978.342382337939;6027.819165425044;6065.5450841187085;6075.45320921117;3391;4856.125897338477;5143.125668636303;5146.047981123466;5273.393559740641;20041.09815058311;20090;20125.899370503055;20126.295579654787;20546.69179962302;1870.1584287070737;1889.990550047241;1904.3620387170315;1906.5233691577105;1983.4727160763598;12409.193402428813;12752.553660621927;12787.552435664707;13173.077884548085;13337.733245335136;1539.7921280627197;1713.9314427422887;1807.3041878876595;1825.2790147891642;1835.180398332196;42189.156216875796;42229.155416891794;42512;42644.360334595;42844;9219.90780092204;9369.859452108223;9478.573464194127;9513;9778;12704.80942785859;12785.360731963365;12791.872081279069;12808.615741527768;12814.487420503076;6579.276279609239;6941.067902398337;7013.544119632207;7064.929350706427;7080.04419403374;6571.648459285799;6628.966855165693;6668.366505182;6721.487665275274;6733.124693789776;5945.970270148708;6106.236720409949;6148.262208534915;6190.442860142609;6192.380761923861;1549.5041586692375;1605.670837478314;1692.6868529322114;1698.5329034515607;1734.7744793177058;820.1716266570687;853.9615717292737;875.3041332140835;876.5660997806;895.552223888056;15456.690866182613;16048;16119.516414507349;16146.86971911955;16672.33310667584;861.0700443520982;864.7319331007408;869.4609342207872;890.7283278600089;892.7768057985504;9374.333222513844;9760.56077476501;9767.365121267096;9835.852462213072;9923.950380248052;364128;371689;374164;374225;378080;64190.35809641844;64226.35773642297;65788.34211657822;66307.66846165835;67155.66422167858;912.6258234123977;919.8850143732034;935.5322338830584;935.5789894547617;943.6932996776076;14841.109533428029;14884.181370024753;15119.773203402177;15241.771373429186;15252.16113113745;22279.44301392478;22533.211337603105;27442.725572744017;31452.370952580364;31739.84130079335;41131.383029253986;41679;42201.78899105485;42766.14467710691;42783.074761636424;7440.925590744023;7506.286902744449;7523.473356865185;7634.274743899321;7698.846023079619;11406.600768973047;11542.82685759731;11749.588764393206;11899.167058305835;11969.760604787682;9520.190783783455;9599.616015359308;9736.95131524338;9762.630553195571;9987.450690212108;9763.707088787347;10060.798784024131;10205.285630006125;10235.283530153116;10245.282830201815;9937.403755774676;10131.341462804894;10307.484625768531;10355.17158627323;10404.895951040695;7343.302386273295;7493.100827900686;7531.359834413917;7567.848643026999;7749.302562769378;9818.803623927624;10051.949740251252;10138.898611013796;10142.54358553852;10259.897401025893 14:50:23 INFO - PROCESS | 6308 | |3;mootools.html;1245.63876475822;1417.7944198091275;1439.9856001439985;1553.5650017994965;1765.311528503883;6821.522493425462;7534.434917381198;7821.960890195555;7829.334506566948;8049.758507244777;7793.92206077939;7909.762707118782;7910.802229944255;7914.28771410573;7935.722249721261;2090.9999999999964;2129.680547917817;2130.872147671137;2130.9786902131013;2133.349328454821;2102.2642075273684;2133.7012818205462;2135.8718476891436;2139.1336508713994;2142.4965133193687;2106.9894650526726;2112.13402504973;2127.755308139568;2128.819050380712;2168.718066651333;2079.896005199749;2081.323569839808;2088.7075809386697;2088.780678028808;2090.0176916849055;2052.8460365472647;2114.9577008459746;2119.5337025854287;2120.491082140275;2121.4484234099245;7276.818079548001;7510.924890751077;7809.062912450486;7860.489068210548;7876.5667888266125;4507.616852567536;4644.396228490275;4648.070385922829;4649.488556258809;4654.4647365553055;2852.115844088339;2909.723576260252;2974.970250297491;2975.345424006715;2975.509041008231;864.6066039951806;869.3610196505564;886.1891369396994;888.7333799860016;898.8427025270552;10483.947580262049;10510.947445262802;10581.20640951924;10584.682459526226;10606.363618182857;3922.490076290064;4032.8790136295956;4075.470188875427;4087.570805065485;4100.097978444797;8316.085230624627;8402;8406.28546573548;8406.453580517247;8413.915860841313;4389.429374181336;4390.473143222834;4392;4396.010897548026;4401.119776044739;3686.64976827201;3937.9606203938165;4028.959710402917;4098;4139.482564679415;3554.964450355515;3620.9637903621156;3700.1859590889962;3723.0878434783654;3733.9439908401396;1147.6614398752388;1160.2400427719688;1174.8721227621409;1175.3124422213102;1177.581958404771;856.5203486047833;862.8360611483798;886.1360173830464;903.6398533941014;921.0329154387999;5261.158214685708;5288.0745869472685;5515.751791169407;5538.280023596906;5548.334199896039;369.27806138998193;388.43482732623966;389.31674910531837;390.6484164252196;391.344497965906;3687.8340474678703;3824.7131465140224;4101.425800387948;4114.300568903293;4121.4848143982;10025;10197.980201979743;10270.281080324306;10270.691879243635;10285.845712314322;9951.850722239173;9992;10064.144547713526;10068;10068;7179.784606461814;7266.164391094986;7303.561786292839;7323.340899319087;7346.485745997729;5387.622866399472;5404.216388623706;5471.398146203835;5538.91691624634;5618.859528511656;8332.625031873702;9007.459552426875;9014.368994170345;9037.457752534869;9039.68361107358;8559.443636163878;8998.14517620825;9007;9014.459132452073;9124.087591240823;5834.824955251349;6053.364396738279;6054.697265136813;6397.6481293529305;6565.671716414256;6670.366315200048;6895.827604309932;6976.790696279119;6978.441724661913;7205.747798827016;6246.6876656167915;6341.207349081365;6362.77730279438;6367.140436041075;6370.617762934239;6274;6413.615183089029;6554.80335589933;6562.442192413699;6658.167729033871;6366.872662546816;6379.298277189599;6427.967860160669;6442.387973142544;6451.387118223761;4417.293233082692;4762.547557981986;4830.661853670209;4852.272159176152;4866.513348665105;4776.928346074881;4827.396575428072;4838;4880.487548807324;4937.629677774253 14:50:23 INFO - PROCESS | 6308 | |4;prototype.html;293.7136292115188;295.2162009863812;298.74009611637865;299.24440787012776;303.47650303226936;4807.375041244638;4835.929184967545;4858.271259311101;4866.902661946759;4871.878203044921;4774.40319960005;4785.234362501992;4793.424789025322;4802.735849528274;4811.951880481194;3557.1680584499068;3658;3659.963400365989;3746.232022435408;3810.6951443884564;3740.28934502445;3772.4529943158363;3777.7533413973324;3782.3191825471404;3783.3946568549036;3753.2118255166447;3755.061234691327;3757.28611563802;3762.2505534926254;3771.2457508498273;3536.6286539913326;3610.8736194233206;3768.8869333920024;3772.396416573335;3782.224643947984;3317.5189597508224;3334.749893757978;3342.097633638904;3344.4816053511745;3348.2131699050706;4575.336576196466;4582.793774280165;4613.192691279046;4616.976915115437;4636.629069674418;4168.812403441822;4196.181744559812;4256.871199668241;4257.510386305584;4279.694693118598;4944.258361245806;4957.975210123962;4961.973196350224;4964.851054468371;4985.651004429691;3614.8011859347725;3619.5294611700574;3635;3635.509206257148;3647.7628954118163;4953.761559610061;5264.973675131638;5269.1832765921345;5275.182346736262;5278.947210527884;3586.8923932282073;3602.85588576454;3605.3149901518627;3612.4581312802766;3630.981845090758;3653.397189463709;3654.945175822365;3667.394879844796;3670.871519496858;3682.2451397463456;4177.809324342547;4181.390164786579;4187.330027195634;4214.852480163179;4226.978865105716;4745.579754325319;4932.654714170046;4966.255061740768;4990;4997.85006449807;1251.649538129307;1259.250745806244;1274.1590550236986;1276.234259444326;1277.2591896699892;801.9719309824128;805.7139715400948;811.7118422959883;843.6456688190851;864.8918885139358;4386.210482113186;4387.5393083726385;4403.4495688039;4413.7793110344355;4413.911721765547;5029.497050294941;5047.318611987334;5049.722265275372;5100.546344291859;5104.2088476286235;4227.704060715781;4354.738715677006;4401.625861801783;4417.359482875029;4426.336049592523;2751.2021513761188;2751.931201719973;2765;2770.847603381793;2777.069681656668;4907.950920490821;4935.679180853233;4936.777844996912;4951.183054795991;4970.403551573762;4970.776315065831;5294.788208471695;5296.973515132399;5330.307060082165;5366.517013468807;4889;4891.706497610155;4900.324756432676;4922.433920099163;4930.778114984762;5194.480551944926;5207.765650545659;5213.713245771519;5223.817166399158;5241.633085683966;4943.431505376928;5096.923546146885;5120.667156634807;5123.692578445305;5142.562882155059;4906.362172917497;4911.263310503453;4913.385826771653;4917.278952366786;4919.655624106278;3681.1410237829723;3681.631836816297;3692.7968961707365;3694.6674799268194;3701.4077747561337;4912.975435122801;5153.7165455900285;5236.219685307014;5254.133068043883;5255.658382205144;5004.17431123875;5008.474110218374;5012;5040.193569028937;5043.798248070036;4987.351644286219;4999.150144475375;5023.949760502348;5028.145215313332;5028.949710502994;4806.158922188673;4903.705777653352;4936.950630493793;4937.975310123426;4946.455889852042;4807.8989052061925;4928;5016.698998060128;5064.290999260033;5078.97460512695;4842.201036828884;4871.806407430202;4878.975605122094;4891.364122664173;4910.950890491049 14:50:23 INFO - PROCESS | 6308 | |5;yui.html;611.2664802237315;620.1070458539705;634.6890023888295;637.3690046853617;637.4358692557089;12276.754464910708;13809.654758631039;13840.653983650389;13868;13877;12806.935965320185;12984.220946743202;12984.350782460886;12991.935040324808;13020;635.5233574818886;771.6604693934651;804.4489524675587;815.6941147069849;817.4237162800212;813.8494378539989;816.4366587054943;819.3117781063905;819.3486178488116;819.5164852736884;845.1970627903486;846.4836449765638;851.4933614499394;851.5316575883239;851.7146755836802;643.983900402489;672.1329484964366;672.3780503034674;672.5493919074232;845.71245776436;592.1502643706252;617.9196704428396;621.0590954703628;622.8816524860262;623.3174673732256;13135.146215495963;13170.34148292591;13172.341382930816;13176.802347964789;13187.340632968313;12468.563600273947;12797.296148711817;12921.353932303442;12928.40480890006;12945.546905858344;11454.828177577343;11490.827637585442;11506.88493115075;11711.121665875009;11798.528058877635;4104.486939132608;4218.8523401680795;4279.5078565965005;4299.312110062375;4307;55663.44336556623;56478.87042259173;57038.714806425705;57103;57142.428575714126;10214.336068155546;10292.897071029194;10336.896631033744;10489.055984961238;10673.519691613896;18738.531536711693;18750.906245468686;18754;18754.343597974006;18778.906105469658;6376.458001069961;6401.615903045832;6434.163558737334;6484.25431075423;6557.7704780333415;3715.554133503997;3717.219383929405;3767.6232376762105;3817.2365526894732;3966.8809935701975;2812.31098380898;2919.4307110113323;2921.3134913295357;2921.3719050404266;2925.795194336376;480.5026797264884;481.85062630584633;486.81501029608523;487.20342240436435;505.6031015652695;512.0041519245107;519.9584033277329;557.1058451185869;570.7117905457717;575.9366469688331;7876.448648594544;7891.171427000198;8044.597770111471;8131.512109273463;8147.83704325922;490.4996903158758;559.3371854352605;562.7833284185618;568.5650477384804;571.274481408617;3736.4582135590185;3771.396576547794;3779.773213607137;3808.7524310919703;3834.1181528248103;83826.58086709527;86232;86836.13163868406;90063.54968225116;90922.54538727396;49187.99999999929;56628.71685641628;66692.33307666959;72929;74135.25864741283;68023.31976680268;69697.30302696908;69922.65038674774;70008;71658.28341716621;7183.245759195209;7288.08898887639;7306.634668266672;7330.45021623391;7357.484976051625;41560.584394155674;42563.3615495774;43182.35226471668;43521.34717979296;44016.77991610021;58550.41449585449;60428.79142417215;60542.697286513285;60610.93890610903;60779.39220607738;8690.78273043179;9276.350655454053;9411.952940235255;9605.759856003655;9635;9702.272329575451;10027.749306267402;10372.688819335432;10478.37129772216;10542.420166890588;7690.923090769021;9115.316351273548;9320;11639.41802909868;12177.147599667938;11910.404479776149;12135.817962730389;12349;12444.688882778002;12485.636921355435;11688.649340519798;11799;11935.224210426642;12479.812802807783;12506.74986500283;9428.292878034312;9864.506774661382;9992;10043;10366.506219605215;9869.901300986898;10375.584976600852;10376.221783366127;10394.168466522811;10403.53184106732 14:50:23 INFO - PROCESS | 6308 | __end_tp_report 14:50:23 INFO - PROCESS | 6308 | __start_cc_report 14:50:23 INFO - PROCESS | 6308 | _x_x_mozilla_cycle_collect,871 14:50:23 INFO - PROCESS | 6308 | __end_cc_report 14:50:23 INFO - PROCESS | 6308 | __startTimestamp1464990623685__endTimestamp 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | ------- Summary: start ------- 14:50:23 INFO - PROCESS | 6308 | Number of tests: 6 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | [#0] dojo.html Cycles:165 Average:4705.07 Median:4840.44 stddev:499.55 (10.3%) stddev-sans-first:475.31 14:50:23 INFO - PROCESS | 6308 | Values: 2686.1 2697.0 2712.0 2730.5 2745.3 4588.0 4680.3 4709.5 4715.7 4795.0 4706.9 4726.1 4738.5 4750.2 4757.1 4156.6 4319.8 4384.5 4434.1 4527.5 4434.8 4477.6 4488.0 4492.6 4523.6 4262.7 4313.1 4318.3 4324.2 4375.4 4333.8 4342.3 4347.8 4399.1 4404.6 4367.3 4369.7 4391.5 4420.4 4426.0 4522.6 4627.3 4662.7 4674.3 4692.7 5164.9 5209.1 5219.4 5227.5 5232.0 5177.0 5228.7 5228.7 5233.0 5247.2 4670.9 4750.6 4801.4 4806.1 4869.8 5290.4 5311.3 5312.9 5317.4 5318.3 4886.7 5042.4 5106.1 5109.3 5112.4 5061.6 5085.7 5095.0 5099.7 5109.3 5047.4 5049.0 5054.4 5057.3 5104.5 4906.6 4951.7 5019.2 5034.4 5035.5 4255.3 4267.9 4270.3 4304.2 4319.6 3720.6 3733.5 3736.9 3762.1 3772.0 4225.3 4249.9 4258.5 4348.6 4350.2 5004.0 5064.6 5093.0 5099.7 5124.8 4355.9 4380.8 4390.1 4390.5 4440.2 4440.6 4603.4 4610.3 4615.9 4642.4 4670.1 4701.1 4743.6 4744.6 4749.1 5038.2 5047.7 5049.1 5084.9 5121.2 4838.3 4840.4 4880.4 4884.2 4889.0 5059.8 5060.9 5062.5 5068.2 5111.4 4938.4 5023.6 5084.5 5115.7 5123.7 4917.3 4936.4 4946.3 5000.0 5001.4 4933.4 4934.2 4937.4 4938.6 4993.9 4643.0 4834.0 4850.8 4860.2 4900.1 5023.9 5030.0 5043.5 5050.2 5118.0 4890.2 4902.6 4905.4 4906.1 4940.0 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | [#1] ext.html Cycles:180 Average:46138.22 Median:19998.96 stddev:83069.93 (415.4%) stddev-sans-first:83232.49 14:50:23 INFO - PROCESS | 6308 | Values: 563.6 597.5 598.9 618.4 622.2 28850.7 39711.4 40979.2 41007.6 41150.6 41925.8 42291.4 42369.6 42408.0 42440.8 7483.4 7688.9 7911.4 7917.2 9760.3 9623.2 10072.7 10074.1 10075.0 10086.9 9969.3 10018.8 10081.4 10083.1 10083.5 9957.6 10051.5 10055.9 10069.1 10070.5 9878.0 9948.4 9978.8 9980.1 9986.4 38908.6 39462.4 39462.8 39495.0 39517.6 2928.2 3195.7 3681.8 3726.2 3828.4 27490.0 29798.0 29840.1 30096.4 31286.8 3142.9 3315.8 3361.2 3467.6 3504.5 262921.0 264479.0 265109.0 265893.0 266407.7 29806.0 30935.5 57000.7 57855.0 57886.0 33097.0 33285.8 33287.5 33345.0 33353.5 12326.5 12329.2 12374.1 12497.3 12639.2 9696.2 9987.7 10034.2 10059.2 10417.7 7967.3 7980.2 8010.9 8062.1 8075.6 3087.1 3101.8 3103.1 3126.8 3146.8 914.8 952.6 954.6 968.8 982.6 26191.0 27317.0 27516.9 27921.2 27932.0 945.3 952.7 963.8 975.1 1046.3 14520.3 14817.3 14917.9 15148.1 15177.8 379064.0 381563.0 381614.0 384739.0 385818.0 48918.0 49452.5 49455.8 49498.3 49526.3 1077.1 1191.6 1194.8 1197.4 1238.5 27717.7 29177.5 29260.7 29398.1 29780.0 42863.8 43404.0 43418.8 43420.6 43433.0 281217.0 288053.0 288150.0 288459.0 289421.0 22419.7 24657.8 25179.9 25651.4 27300.3 41956.0 43304.8 43504.0 43761.5 48329.8 37282.8 38262.2 38584.2 38989.8 39055.4 37222.3 37267.3 37510.0 37653.6 37658.6 36493.5 36580.5 36764.8 36819.6 37034.4 32450.5 33548.0 33841.5 33853.3 33858.3 24702.6 24723.1 25010.7 25271.4 25301.4 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | [#2] jquery.html Cycles:180 Average:22223.05 Median:42578.18 stddev:60828.80 (142.9%) stddev-sans-first:60977.29 14:50:23 INFO - PROCESS | 6308 | Values: 362.0 365.8 365.8 378.8 390.7 15680.5 16792.8 16905.3 17196.8 17399.1 15227.6 15290.8 15338.8 15391.2 16081.4 4938.9 5126.9 5134.5 5165.1 5168.9 3752.9 3956.3 5112.1 5684.1 6014.3 6025.6 6065.6 6105.8 6117.2 6118.5 5844.3 5978.3 6027.8 6065.5 6075.5 3391.0 4856.1 5143.1 5146.0 5273.4 20041.1 20090.0 20125.9 20126.3 20546.7 1870.2 1890.0 1904.4 1906.5 1983.5 12409.2 12752.6 12787.6 13173.1 13337.7 1539.8 1713.9 1807.3 1825.3 1835.2 42189.2 42229.2 42512.0 42644.4 42844.0 9219.9 9369.9 9478.6 9513.0 9778.0 12704.8 12785.4 12791.9 12808.6 12814.5 6579.3 6941.1 7013.5 7064.9 7080.0 6571.6 6629.0 6668.4 6721.5 6733.1 5946.0 6106.2 6148.3 6190.4 6192.4 1549.5 1605.7 1692.7 1698.5 1734.8 820.2 854.0 875.3 876.6 895.6 15456.7 16048.0 16119.5 16146.9 16672.3 861.1 864.7 869.5 890.7 892.8 9374.3 9760.6 9767.4 9835.9 9924.0 364128.0 371689.0 374164.0 374225.0 378080.0 64190.4 64226.4 65788.3 66307.7 67155.7 912.6 919.9 935.5 935.6 943.7 14841.1 14884.2 15119.8 15241.8 15252.2 22279.4 22533.2 27442.7 31452.4 31739.8 41131.4 41679.0 42201.8 42766.1 42783.1 7440.9 7506.3 7523.5 7634.3 7698.8 11406.6 11542.8 11749.6 11899.2 11969.8 9520.2 9599.6 9737.0 9762.6 9987.5 9763.7 10060.8 10205.3 10235.3 10245.3 9937.4 10131.3 10307.5 10355.2 10404.9 7343.3 7493.1 7531.4 7567.8 7749.3 9818.8 10051.9 10138.9 10142.5 10259.9 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | [#3] mootools.html Cycles:180 Average:5092.67 Median:4802.16 stddev:2886.90 (60.1%) stddev-sans-first:2880.52 14:50:23 INFO - PROCESS | 6308 | Values: 1245.6 1417.8 1440.0 1553.6 1765.3 6821.5 7534.4 7822.0 7829.3 8049.8 7793.9 7909.8 7910.8 7914.3 7935.7 2091.0 2129.7 2130.9 2131.0 2133.3 2102.3 2133.7 2135.9 2139.1 2142.5 2107.0 2112.1 2127.8 2128.8 2168.7 2079.9 2081.3 2088.7 2088.8 2090.0 2052.8 2115.0 2119.5 2120.5 2121.4 7276.8 7510.9 7809.1 7860.5 7876.6 4507.6 4644.4 4648.1 4649.5 4654.5 2852.1 2909.7 2975.0 2975.3 2975.5 864.6 869.4 886.2 888.7 898.8 10483.9 10510.9 10581.2 10584.7 10606.4 3922.5 4032.9 4075.5 4087.6 4100.1 8316.1 8402.0 8406.3 8406.5 8413.9 4389.4 4390.5 4392.0 4396.0 4401.1 3686.6 3938.0 4029.0 4098.0 4139.5 3555.0 3621.0 3700.2 3723.1 3733.9 1147.7 1160.2 1174.9 1175.3 1177.6 856.5 862.8 886.1 903.6 921.0 5261.2 5288.1 5515.8 5538.3 5548.3 369.3 388.4 389.3 390.6 391.3 3687.8 3824.7 4101.4 4114.3 4121.5 10025.0 10198.0 10270.3 10270.7 10285.8 9951.9 9992.0 10064.1 10068.0 10068.0 7179.8 7266.2 7303.6 7323.3 7346.5 5387.6 5404.2 5471.4 5538.9 5618.9 8332.6 9007.5 9014.4 9037.5 9039.7 8559.4 8998.1 9007.0 9014.5 9124.1 5834.8 6053.4 6054.7 6397.6 6565.7 6670.4 6895.8 6976.8 6978.4 7205.7 6246.7 6341.2 6362.8 6367.1 6370.6 6274.0 6413.6 6554.8 6562.4 6658.2 6366.9 6379.3 6428.0 6442.4 6451.4 4417.3 4762.5 4830.7 4852.3 4866.5 4776.9 4827.4 4838.0 4880.5 4937.6 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | [#4] prototype.html Cycles:180 Average:4163.37 Median:4806.77 stddev:1209.74 (25.2%) stddev-sans-first:1177.76 14:50:23 INFO - PROCESS | 6308 | Values: 293.7 295.2 298.7 299.2 303.5 4807.4 4835.9 4858.3 4866.9 4871.9 4774.4 4785.2 4793.4 4802.7 4812.0 3557.2 3658.0 3660.0 3746.2 3810.7 3740.3 3772.5 3777.8 3782.3 3783.4 3753.2 3755.1 3757.3 3762.3 3771.2 3536.6 3610.9 3768.9 3772.4 3782.2 3317.5 3334.7 3342.1 3344.5 3348.2 4575.3 4582.8 4613.2 4617.0 4636.6 4168.8 4196.2 4256.9 4257.5 4279.7 4944.3 4958.0 4962.0 4964.9 4985.7 3614.8 3619.5 3635.0 3635.5 3647.8 4953.8 5265.0 5269.2 5275.2 5278.9 3586.9 3602.9 3605.3 3612.5 3631.0 3653.4 3654.9 3667.4 3670.9 3682.2 4177.8 4181.4 4187.3 4214.9 4227.0 4745.6 4932.7 4966.3 4990.0 4997.9 1251.6 1259.3 1274.2 1276.2 1277.3 802.0 805.7 811.7 843.6 864.9 4386.2 4387.5 4403.4 4413.8 4413.9 5029.5 5047.3 5049.7 5100.5 5104.2 4227.7 4354.7 4401.6 4417.4 4426.3 2751.2 2751.9 2765.0 2770.8 2777.1 4908.0 4935.7 4936.8 4951.2 4970.4 4970.8 5294.8 5297.0 5330.3 5366.5 4889.0 4891.7 4900.3 4922.4 4930.8 5194.5 5207.8 5213.7 5223.8 5241.6 4943.4 5096.9 5120.7 5123.7 5142.6 4906.4 4911.3 4913.4 4917.3 4919.7 3681.1 3681.6 3692.8 3694.7 3701.4 4913.0 5153.7 5236.2 5254.1 5255.7 5004.2 5008.5 5012.0 5040.2 5043.8 4987.4 4999.2 5023.9 5028.1 5028.9 4806.2 4903.7 4937.0 4938.0 4946.5 4807.9 4928.0 5016.7 5064.3 5079.0 4842.2 4871.8 4879.0 4891.4 4911.0 14:50:23 INFO - PROCESS | 6308 | 14:50:23 INFO - PROCESS | 6308 | [#5] yui.html Cycles:180 Average:16415.89 Median:28091.70 stddev:22432.60 (79.9%) stddev-sans-first:22464.14 14:50:23 INFO - PROCESS | 6308 | Values: 611.3 620.1 634.7 637.4 637.4 12276.8 13809.7 13840.7 13868.0 13877.0 12806.9 12984.2 12984.4 12991.9 13020.0 635.5 771.7 804.4 815.7 817.4 813.8 816.4 819.3 819.3 819.5 845.2 846.5 851.5 851.5 851.7 644.0 672.1 672.4 672.5 845.7 592.2 617.9 621.1 622.9 623.3 13135.1 13170.3 13172.3 13176.8 13187.3 12468.6 12797.3 12921.4 12928.4 12945.5 11454.8 11490.8 11506.9 11711.1 11798.5 4104.5 4218.9 4279.5 4299.3 4307.0 55663.4 56478.9 57038.7 57103.0 57142.4 10214.3 10292.9 10336.9 10489.1 10673.5 18738.5 18750.9 18754.0 18754.3 18778.9 6376.5 6401.6 6434.2 6484.3 6557.8 3715.6 3717.2 3767.6 3817.2 3966.9 2812.3 2919.4 2921.3 2921.4 2925.8 480.5 481.9 486.8 487.2 505.6 512.0 520.0 557.1 570.7 575.9 7876.4 7891.2 8044.6 8131.5 8147.8 490.5 559.3 562.8 568.6 571.3 3736.5 3771.4 3779.8 3808.8 3834.1 83826.6 86232.0 86836.1 90063.5 90922.5 49188.0 56628.7 66692.3 72929.0 74135.3 68023.3 69697.3 69922.7 70008.0 71658.3 7183.2 7288.1 7306.6 7330.5 7357.5 41560.6 42563.4 43182.4 43521.3 44016.8 58550.4 60428.8 60542.7 60610.9 60779.4 8690.8 9276.4 9412.0 9605.8 9635.0 9702.3 10027.7 10372.7 10478.4 10542.4 7690.9 9115.3 9320.0 11639.4 12177.1 11910.4 12135.8 12349.0 12444.7 12485.6 11688.6 11799.0 11935.2 12479.8 12506.7 9428.3 9864.5 9992.0 10043.0 10366.5 9869.9 10375.6 10376.2 10394.2 10403.5 14:50:23 INFO - PROCESS | 6308 | -------- Summary: end -------- 14:50:23 INFO - PROCESS | 6308 | 14:50:24 INFO - TEST-INFO | 6308: exit 0 14:50:24 INFO - TEST-OK | dromaeo_css | took 1118903ms 14:50:24 INFO - TEST-START | kraken 14:50:24 INFO - operating with platform_type : linux_ 14:50:24 INFO - Initialising browser for kraken test... 14:50:24 INFO - TEST-INFO | started process 6484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ciVXM/profile http://localhost:54498/getInfo.html) 14:50:28 INFO - PROCESS | 6484 | __metrics Screen width/height:1600/1200 14:50:28 INFO - PROCESS | 6484 | colorDepth:24 14:50:28 INFO - PROCESS | 6484 | Browser inner width/height: 1024/697 14:50:28 INFO - PROCESS | 6484 | __metrics 14:50:29 ERROR - PROCESS | 6484 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:50:30 INFO - TEST-INFO | 6484: exit 0 14:50:30 INFO - Browser initialized. 14:50:30 INFO - Running cycle 1/1 for kraken test... 14:50:30 INFO - TEST-INFO | started process 6564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ciVXM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:42 INFO - PROCESS | 6564 | RSS: Main: 158035968 14:50:42 INFO - PROCESS | 6564 | 14:50:45 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54498/tests/kraken/driver.html?testName=audio-beat-detection) 14:50:46 INFO - PROCESS | 6564 | RSS: Main: 214667264 14:50:46 INFO - PROCESS | 6564 | 14:50:48 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54498/tests/kraken/driver.html?testName=audio-dft) 14:50:49 INFO - PROCESS | 6564 | RSS: Main: 199720960 14:50:49 INFO - PROCESS | 6564 | 14:50:52 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54498/tests/kraken/driver.html?testName=audio-fft) 14:50:53 INFO - PROCESS | 6564 | RSS: Main: 270155776 14:50:53 INFO - PROCESS | 6564 | 14:50:55 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54498/tests/kraken/driver.html?testName=audio-oscillator) 14:50:56 INFO - PROCESS | 6564 | RSS: Main: 180944896 14:50:56 INFO - PROCESS | 6564 | 14:50:58 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54498/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:50:58 INFO - PROCESS | 6564 | RSS: Main: 184111104 14:50:58 INFO - PROCESS | 6564 | 14:51:02 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54498/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:02 INFO - PROCESS | 6564 | RSS: Main: 220545024 14:51:02 INFO - PROCESS | 6564 | 14:51:06 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54498/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:06 INFO - PROCESS | 6564 | RSS: Main: 217362432 14:51:06 INFO - PROCESS | 6564 | 14:51:09 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54498/tests/kraken/driver.html?testName=json-parse-financial) 14:51:10 INFO - PROCESS | 6564 | RSS: Main: 218611712 14:51:10 INFO - PROCESS | 6564 | 14:51:12 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54498/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:12 INFO - PROCESS | 6564 | RSS: Main: 208302080 14:51:12 INFO - PROCESS | 6564 | 14:51:14 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:15 INFO - PROCESS | 6564 | RSS: Main: 212000768 14:51:15 INFO - PROCESS | 6564 | 14:51:17 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:18 INFO - PROCESS | 6564 | RSS: Main: 217530368 14:51:18 INFO - PROCESS | 6564 | 14:51:20 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:21 INFO - PROCESS | 6564 | RSS: Main: 222384128 14:51:21 INFO - PROCESS | 6564 | 14:51:24 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:51:25 INFO - PROCESS | 6564 | RSS: Main: 221429760 14:51:25 INFO - PROCESS | 6564 | 14:51:26 INFO - PROCESS | 6564 | Cycle 1(1): loaded http://localhost:54498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54498/tests/kraken/driver.html?testName=ai-astar) 14:51:27 INFO - PROCESS | 6564 | RSS: Main: 263458816 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | __start_tp_report 14:51:27 INFO - PROCESS | 6564 | _x_x_mozilla_page_load 14:51:27 INFO - PROCESS | 6564 | _x_x_mozilla_page_load_details 14:51:27 INFO - PROCESS | 6564 | |i|pagename|runs| 14:51:27 INFO - PROCESS | 6564 | |0;ai-astar;113;108;113;114;112;113;112;112;114;113 14:51:27 INFO - PROCESS | 6564 | |1;audio-beat-detection;156;130;131;187;129;163;155;130;194;137 14:51:27 INFO - PROCESS | 6564 | |2;audio-dft;162;161;160;161;160;161;162;162;159;162 14:51:27 INFO - PROCESS | 6564 | |3;audio-fft;76;76;76;131;77;77;75;77;106;76 14:51:27 INFO - PROCESS | 6564 | |4;audio-oscillator;86;87;114;87;87;86;135;87;87;123 14:51:27 INFO - PROCESS | 6564 | |5;imaging-gaussian-blur;117;117;117;116;117;118;116;116;117;117 14:51:27 INFO - PROCESS | 6564 | |6;imaging-darkroom;146;147;147;146;146;147;149;145;146;146 14:51:27 INFO - PROCESS | 6564 | |7;imaging-desaturate;95;96;95;95;95;96;95;94;95;95 14:51:27 INFO - PROCESS | 6564 | |8;json-parse-financial;64;64;64;65;65;67;65;64;64;63 14:51:27 INFO - PROCESS | 6564 | |9;json-stringify-tinderbox;65;64;65;65;65;65;66;65;65;66 14:51:27 INFO - PROCESS | 6564 | |10;stanford-crypto-aes;83;82;83;84;88;84;84;84;119;84 14:51:27 INFO - PROCESS | 6564 | |11;stanford-crypto-ccm;143;135;143;143;133;131;131;133;134;143 14:51:27 INFO - PROCESS | 6564 | |12;stanford-crypto-pbkdf2;165;166;166;169;169;170;166;166;166;169 14:51:27 INFO - PROCESS | 6564 | |13;stanford-crypto-sha256-iterative;67;68;68;69;69;74;67;67;66;65 14:51:27 INFO - PROCESS | 6564 | __end_tp_report 14:51:27 INFO - PROCESS | 6564 | __start_cc_report 14:51:27 INFO - PROCESS | 6564 | _x_x_mozilla_cycle_collect,1919 14:51:27 INFO - PROCESS | 6564 | __end_cc_report 14:51:27 INFO - PROCESS | 6564 | __startTimestamp1464990687094__endTimestamp 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | ------- Summary: start ------- 14:51:27 INFO - PROCESS | 6564 | Number of tests: 14 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:1.71 (1.5%) stddev-sans-first:1.80 14:51:27 INFO - PROCESS | 6564 | Values: 113.0 108.0 113.0 114.0 112.0 113.0 112.0 112.0 114.0 113.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.50 stddev:24.25 (15.6%) stddev-sans-first:25.66 14:51:27 INFO - PROCESS | 6564 | Values: 156.0 130.0 131.0 187.0 129.0 163.0 155.0 130.0 194.0 137.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.05 14:51:27 INFO - PROCESS | 6564 | Values: 162.0 161.0 160.0 161.0 160.0 161.0 162.0 162.0 159.0 162.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#3] audio-fft Cycles:10 Average:84.70 Median:76.00 stddev:18.77 (24.7%) stddev-sans-first:19.65 14:51:27 INFO - PROCESS | 6564 | Values: 76.0 76.0 76.0 131.0 77.0 77.0 75.0 77.0 106.0 76.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:87.00 stddev:18.69 (21.5%) stddev-sans-first:19.32 14:51:27 INFO - PROCESS | 6564 | Values: 86.0 87.0 114.0 87.0 87.0 86.0 135.0 87.0 87.0 123.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 14:51:27 INFO - PROCESS | 6564 | Values: 117.0 117.0 117.0 116.0 117.0 118.0 116.0 116.0 117.0 117.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 14:51:27 INFO - PROCESS | 6564 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 149.0 145.0 146.0 146.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:51:27 INFO - PROCESS | 6564 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:1.08 (1.7%) stddev-sans-first:1.13 14:51:27 INFO - PROCESS | 6564 | Values: 64.0 64.0 64.0 65.0 65.0 67.0 65.0 64.0 64.0 63.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 14:51:27 INFO - PROCESS | 6564 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.00 stddev:11.18 (13.3%) stddev-sans-first:11.74 14:51:27 INFO - PROCESS | 6564 | Values: 83.0 82.0 83.0 84.0 88.0 84.0 84.0 84.0 119.0 84.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#11] stanford-crypto-ccm Cycles:10 Average:136.90 Median:139.00 stddev:5.38 (3.9%) stddev-sans-first:5.24 14:51:27 INFO - PROCESS | 6564 | Values: 143.0 135.0 143.0 143.0 133.0 131.0 131.0 133.0 134.0 143.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.50 stddev:1.81 (1.1%) stddev-sans-first:1.74 14:51:27 INFO - PROCESS | 6564 | Values: 165.0 166.0 166.0 169.0 169.0 170.0 166.0 166.0 166.0 169.0 14:51:27 INFO - PROCESS | 6564 | 14:51:27 INFO - PROCESS | 6564 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.45 (3.6%) stddev-sans-first:2.57 14:51:27 INFO - PROCESS | 6564 | Values: 67.0 68.0 68.0 69.0 69.0 74.0 67.0 67.0 66.0 65.0 14:51:27 INFO - PROCESS | 6564 | -------- Summary: end -------- 14:51:27 INFO - PROCESS | 6564 | 14:51:28 INFO - TEST-INFO | 6564: exit 0 14:51:28 INFO - TEST-OK | kraken | took 63610ms 14:51:28 INFO - SUITE-END | took 1182s 14:51:28 INFO - Completed test suite (00:19:42) 14:51:28 INFO - javascript benchmark 14:51:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.127008722166, 2696.973030269697, 2711.955896979663, 2730.5221586222406, 2745.341118131649, 4588.0, 4680.3447517347595, 4709.481956984733, 4715.717056976584, 4795.017021510591, 4706.858794236178, 4726.0784147091335, 4738.502457241992, 4750.16872047392, 4757.096151731169, 4156.6051225133715, 4319.805608747606, 4384.539623339551, 4434.135343607998, 4527.547245275479, 4434.778261086949, 4477.597016268535, 4487.977560112211, 4492.573205545468, 4523.638108951292, 4262.701610887224, 4313.1158112586845, 4318.287482565404, 4324.243257429968, 4375.431193944767, 4333.761643109628, 4342.30523116303, 4347.760873151976, 4399.054203346264, 4404.647628189737, 4367.344898265285, 4369.650427965755, 4391.516933137353, 4420.359047938063, 4426.048399594103, 4522.570355816192, 4627.282771170474, 4662.696924699883, 4674.298855171717, 4692.741899195543, 5164.948350516484, 5209.1404918188455, 5219.373675159005, 5227.451117632631, 5232.03207406631, 5176.974115129438, 5228.660137091077, 5228.738563071831, 5233.031889100528, 5247.2129180623215, 4670.859874203746, 4750.643701722384, 4801.423829140525, 4806.134895718735, 4869.780859861315, 5290.418054014055, 5311.28297679816, 5312.946870531323, 5317.41508434072, 5318.282031925718, 4886.65793394459, 5042.445331013586, 5106.106431374495, 5109.259157422153, 5112.437631860493, 5061.645684802103, 5085.694858308513, 5094.974525127351, 5099.6685215460875, 5109.335786347825, 5047.41954675217, 5048.974755126274, 5054.393472783289, 5057.291979122926, 5104.464031276737, 4906.55840974314, 4951.653384263139, 5019.247112933089, 5034.395872495251, 5035.496450355008, 4255.340422234559, 4267.871963841089, 4270.29540125882, 4304.225239456865, 4319.589638984291, 3720.5907350191455, 3733.4586484959527, 3736.850525978985, 3762.078290818767, 3772.038130276817, 4225.260579398593, 4249.936250956238, 4258.510271318776, 4348.608625223682, 4350.195213885441, 5003.974980125076, 5064.594832413398, 5093.032323858455, 5099.69401835891, 5124.846254612367, 4355.934660980088, 4380.802863871133, 4390.143921935256, 4390.495093064274, 4440.200763862471, 4440.62254708347, 4603.355530225771, 4610.2854057621125, 4615.930761038587, 4642.419697537808, 4670.1126785910565, 4701.059788042337, 4743.5967942724565, 4744.572988431058, 4749.050189961952, 5038.193888977746, 5047.7476126192805, 5049.141645920276, 5084.949150508448, 5121.206213036985, 4838.250071238964, 4840.443349014768, 4880.438749543706, 4884.194107972145, 4888.95111048885, 5059.822906198266, 5060.8987820242655, 5062.468440813809, 5068.239764035424, 5111.412187598474, 4938.407391113089, 5023.648344615842, 5084.466131056186, 5115.693058416507, 5123.666961647481, 4917.311576379238, 4936.407631084293, 4946.307516947702, 5000.024995126061, 5001.449840517467, 4933.383327084114, 4934.235193545006, 4937.35814344133, 4938.629602779734, 4993.850184494471, 4642.953570464252, 4833.975830120827, 4850.80596776125, 4860.17377045896, 4900.093482705711, 5023.899522009612, 5029.974850125726, 5043.5460808527405, 5050.217216331474, 5117.974410127926, 4890.24201248807, 4902.607791376753, 4905.386826646669, 4906.092372911023, 4939.975300123477], "value": 4673.470509881251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5998441106814, 597.4801922327574, 598.8562744941215, 618.3908849782964, 622.2129006806391, 28850.711492885064, 39711.40432893505, 40979.18041639165, 41007.56473523431, 41150.58849411512, 41925.790371048104, 42291.3656295155, 42369.57630423702, 42408.0, 42440.78779606098, 7483.4013278937555, 7688.884666730003, 7911.446198766089, 7917.168697286788, 9760.2679799015, 9623.1820295275, 10072.748181295454, 10074.143697785661, 10075.042870927251, 10086.899131008706, 9969.302148849583, 10018.799624007515, 10081.39511629301, 10083.092521673048, 10083.495825208747, 9957.55191016406, 10051.547680354402, 10055.89944100557, 10069.144122749574, 10070.496475176213, 9877.950610246902, 9948.353357031841, 9978.750531236705, 9980.101790838788, 9986.400815950994, 38908.610913890785, 39462.40806387906, 39462.80268598667, 39495.0, 39517.60482395168, 2928.2240206345336, 3195.72836308914, 3681.8159092045557, 3726.1802403471193, 3828.3874580067054, 27490.0378486754, 29798.0, 29840.10479685591, 30096.398072038657, 31286.843565782252, 3142.858571364294, 3315.800252756078, 3361.1765117546356, 3467.6358982306747, 3504.4743288506675, 262921.0, 264479.0, 265109.0, 265893.0, 266407.6679616609, 29806.0, 30935.535966960513, 57000.71499642475, 57855.0, 57886.0, 33097.01417914885, 33285.833570831994, 33287.50068748971, 33344.99965001054, 33353.49969750456, 12326.50693972231, 12329.198602090835, 12374.071944604011, 12497.312647804276, 12639.241645501299, 9696.224302055818, 9987.700368988943, 10034.24743144267, 10059.245556583286, 10417.739556511147, 7967.322777563972, 7980.201979801974, 8010.879836802453, 8062.072861620872, 8075.5558444286125, 3087.073877836685, 3101.7518598512065, 3103.0845900459417, 3126.765492588065, 3146.7639927005566, 914.8307563100715, 952.5899474329956, 954.627695198873, 968.8498282766183, 982.5922242269521, 26191.0, 27317.0, 27516.862415687792, 27921.16236512908, 27932.0, 945.3382632157517, 952.7332346942867, 963.8120566489467, 975.1370037516849, 1046.3198920701452, 14520.346584403727, 14817.333220005126, 14917.850821491864, 15148.091114532943, 15177.848221517865, 379064.0, 381563.0, 381614.0, 384739.0, 385818.0, 48918.0, 49452.50547494479, 49455.75272123616, 49498.25752613714, 49526.257106143436, 1077.0737166037202, 1191.642507247822, 1194.75507520958, 1197.3713800254936, 1238.4612693478366, 27717.72282277232, 29177.541122944192, 29260.707392925797, 29398.11805645834, 29780.0, 42863.78568107139, 43404.0, 43418.78290608527, 43420.56579434165, 43433.0, 281217.0, 288053.0, 288150.0, 288459.0, 289421.0, 22419.663705044764, 24657.753422465546, 25179.866905989642, 25651.358716031504, 27300.31749206286, 41955.95110122149, 43304.78347608242, 43504.0, 43761.490683229815, 48329.75835120802, 37282.81358593189, 38262.23475530418, 38584.2283154341, 38989.8050509757, 39055.41416878692, 37222.25555488821, 37267.254654907294, 37510.0, 37653.62346376611, 37658.62341376551, 36493.45259821052, 36580.45129323009, 36764.816175918946, 36819.63180368162, 37034.44448333331, 32450.513242300913, 33548.0, 33841.49237761485, 33853.3229335407, 33858.3228335427, 24702.641354724943, 24723.134690285755, 25010.65569708069, 25271.36821579475, 25301.367465813502], "value": 17028.642362686864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.97828130312183, 365.77322060322604, 365.8481730082016, 378.8314200180919, 390.7245391998641, 15680.52958411248, 16792.83207167928, 16905.323787048535, 17196.82803171968, 17399.130043497837, 15227.619309517268, 15290.770638440405, 15338.846611533882, 15391.230438478087, 16081.356745730156, 4938.925916111252, 5126.897462050757, 5134.537891589756, 5165.096108181072, 5168.948310516885, 3752.9437058444146, 3956.287868183726, 5112.079825631404, 5684.118961560965, 6014.308354539218, 6025.578209525335, 6065.636061836304, 6105.786297479589, 6117.235345581802, 6118.4799292060225, 5844.26946631671, 5978.342382337939, 6027.819165425044, 6065.5450841187085, 6075.45320921117, 3391.0, 4856.125897338477, 5143.125668636303, 5146.047981123466, 5273.393559740641, 20041.09815058311, 20090.0, 20125.899370503055, 20126.295579654787, 20546.69179962302, 1870.1584287070737, 1889.990550047241, 1904.3620387170315, 1906.5233691577105, 1983.4727160763598, 12409.193402428813, 12752.553660621927, 12787.552435664707, 13173.077884548085, 13337.733245335136, 1539.7921280627197, 1713.9314427422887, 1807.3041878876595, 1825.2790147891642, 1835.180398332196, 42189.156216875796, 42229.155416891794, 42512.0, 42644.360334595, 42844.0, 9219.90780092204, 9369.859452108223, 9478.573464194127, 9513.0, 9778.0, 12704.80942785859, 12785.360731963365, 12791.872081279069, 12808.615741527768, 12814.487420503076, 6579.276279609239, 6941.067902398337, 7013.544119632207, 7064.929350706427, 7080.04419403374, 6571.648459285799, 6628.966855165693, 6668.366505182, 6721.487665275274, 6733.124693789776, 5945.970270148708, 6106.236720409949, 6148.262208534915, 6190.442860142609, 6192.380761923861, 1549.5041586692375, 1605.670837478314, 1692.6868529322114, 1698.5329034515607, 1734.7744793177058, 820.1716266570687, 853.9615717292737, 875.3041332140835, 876.5660997806, 895.552223888056, 15456.690866182613, 16048.0, 16119.516414507349, 16146.86971911955, 16672.33310667584, 861.0700443520982, 864.7319331007408, 869.4609342207872, 890.7283278600089, 892.7768057985504, 9374.333222513844, 9760.56077476501, 9767.365121267096, 9835.852462213072, 9923.950380248052, 364128.0, 371689.0, 374164.0, 374225.0, 378080.0, 64190.35809641844, 64226.35773642297, 65788.34211657822, 66307.66846165835, 67155.66422167858, 912.6258234123977, 919.8850143732034, 935.5322338830584, 935.5789894547617, 943.6932996776076, 14841.109533428029, 14884.181370024753, 15119.773203402177, 15241.771373429186, 15252.16113113745, 22279.44301392478, 22533.211337603105, 27442.725572744017, 31452.370952580364, 31739.84130079335, 41131.383029253986, 41679.0, 42201.78899105485, 42766.14467710691, 42783.074761636424, 7440.925590744023, 7506.286902744449, 7523.473356865185, 7634.274743899321, 7698.846023079619, 11406.600768973047, 11542.82685759731, 11749.588764393206, 11899.167058305835, 11969.760604787682, 9520.190783783455, 9599.616015359308, 9736.95131524338, 9762.630553195571, 9987.450690212108, 9763.707088787347, 10060.798784024131, 10205.285630006125, 10235.283530153116, 10245.282830201815, 9937.403755774676, 10131.341462804894, 10307.484625768531, 10355.17158627323, 10404.895951040695, 7343.302386273295, 7493.100827900686, 7531.359834413917, 7567.848643026999, 7749.302562769378, 9818.803623927624, 10051.949740251252, 10138.898611013796, 10142.54358553852, 10259.897401025893], "value": 7964.6981668548715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.63876475822, 1417.7944198091275, 1439.9856001439985, 1553.5650017994965, 1765.311528503883, 6821.522493425462, 7534.434917381198, 7821.960890195555, 7829.334506566948, 8049.758507244777, 7793.92206077939, 7909.762707118782, 7910.802229944255, 7914.28771410573, 7935.722249721261, 2090.9999999999964, 2129.680547917817, 2130.872147671137, 2130.9786902131013, 2133.349328454821, 2102.2642075273684, 2133.7012818205462, 2135.8718476891436, 2139.1336508713994, 2142.4965133193687, 2106.9894650526726, 2112.13402504973, 2127.755308139568, 2128.819050380712, 2168.718066651333, 2079.896005199749, 2081.323569839808, 2088.7075809386697, 2088.780678028808, 2090.0176916849055, 2052.8460365472647, 2114.9577008459746, 2119.5337025854287, 2120.491082140275, 2121.4484234099245, 7276.818079548001, 7510.924890751077, 7809.062912450486, 7860.489068210548, 7876.5667888266125, 4507.616852567536, 4644.396228490275, 4648.070385922829, 4649.488556258809, 4654.4647365553055, 2852.115844088339, 2909.723576260252, 2974.970250297491, 2975.345424006715, 2975.509041008231, 864.6066039951806, 869.3610196505564, 886.1891369396994, 888.7333799860016, 898.8427025270552, 10483.947580262049, 10510.947445262802, 10581.20640951924, 10584.682459526226, 10606.363618182857, 3922.490076290064, 4032.8790136295956, 4075.470188875427, 4087.570805065485, 4100.097978444797, 8316.085230624627, 8402.0, 8406.28546573548, 8406.453580517247, 8413.915860841313, 4389.429374181336, 4390.473143222834, 4392.0, 4396.010897548026, 4401.119776044739, 3686.64976827201, 3937.9606203938165, 4028.959710402917, 4098.0, 4139.482564679415, 3554.964450355515, 3620.9637903621156, 3700.1859590889962, 3723.0878434783654, 3733.9439908401396, 1147.6614398752388, 1160.2400427719688, 1174.8721227621409, 1175.3124422213102, 1177.581958404771, 856.5203486047833, 862.8360611483798, 886.1360173830464, 903.6398533941014, 921.0329154387999, 5261.158214685708, 5288.0745869472685, 5515.751791169407, 5538.280023596906, 5548.334199896039, 369.27806138998193, 388.43482732623966, 389.31674910531837, 390.6484164252196, 391.344497965906, 3687.8340474678703, 3824.7131465140224, 4101.425800387948, 4114.300568903293, 4121.4848143982, 10025.0, 10197.980201979743, 10270.281080324306, 10270.691879243635, 10285.845712314322, 9951.850722239173, 9992.0, 10064.144547713526, 10068.0, 10068.0, 7179.784606461814, 7266.164391094986, 7303.561786292839, 7323.340899319087, 7346.485745997729, 5387.622866399472, 5404.216388623706, 5471.398146203835, 5538.91691624634, 5618.859528511656, 8332.625031873702, 9007.459552426875, 9014.368994170345, 9037.457752534869, 9039.68361107358, 8559.443636163878, 8998.14517620825, 9007.0, 9014.459132452073, 9124.087591240823, 5834.824955251349, 6053.364396738279, 6054.697265136813, 6397.6481293529305, 6565.671716414256, 6670.366315200048, 6895.827604309932, 6976.790696279119, 6978.441724661913, 7205.747798827016, 6246.6876656167915, 6341.207349081365, 6362.77730279438, 6367.140436041075, 6370.617762934239, 6274.0, 6413.615183089029, 6554.80335589933, 6562.442192413699, 6658.167729033871, 6366.872662546816, 6379.298277189599, 6427.967860160669, 6442.387973142544, 6451.387118223761, 4417.293233082692, 4762.547557981986, 4830.661853670209, 4852.272159176152, 4866.513348665105, 4776.928346074881, 4827.396575428072, 4838.0, 4880.487548807324, 4937.629677774253], "value": 4023.201855201722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.7136292115188, 295.2162009863812, 298.74009611637865, 299.24440787012776, 303.47650303226936, 4807.375041244638, 4835.929184967545, 4858.271259311101, 4866.902661946759, 4871.878203044921, 4774.40319960005, 4785.234362501992, 4793.424789025322, 4802.735849528274, 4811.951880481194, 3557.1680584499068, 3658.0, 3659.963400365989, 3746.232022435408, 3810.6951443884564, 3740.28934502445, 3772.4529943158363, 3777.7533413973324, 3782.3191825471404, 3783.3946568549036, 3753.2118255166447, 3755.061234691327, 3757.28611563802, 3762.2505534926254, 3771.2457508498273, 3536.6286539913326, 3610.8736194233206, 3768.8869333920024, 3772.396416573335, 3782.224643947984, 3317.5189597508224, 3334.749893757978, 3342.097633638904, 3344.4816053511745, 3348.2131699050706, 4575.336576196466, 4582.793774280165, 4613.192691279046, 4616.976915115437, 4636.629069674418, 4168.812403441822, 4196.181744559812, 4256.871199668241, 4257.510386305584, 4279.694693118598, 4944.258361245806, 4957.975210123962, 4961.973196350224, 4964.851054468371, 4985.651004429691, 3614.8011859347725, 3619.5294611700574, 3635.0, 3635.509206257148, 3647.7628954118163, 4953.761559610061, 5264.973675131638, 5269.1832765921345, 5275.182346736262, 5278.947210527884, 3586.8923932282073, 3602.85588576454, 3605.3149901518627, 3612.4581312802766, 3630.981845090758, 3653.397189463709, 3654.945175822365, 3667.394879844796, 3670.871519496858, 3682.2451397463456, 4177.809324342547, 4181.390164786579, 4187.330027195634, 4214.852480163179, 4226.978865105716, 4745.579754325319, 4932.654714170046, 4966.255061740768, 4990.0, 4997.85006449807, 1251.649538129307, 1259.250745806244, 1274.1590550236986, 1276.234259444326, 1277.2591896699892, 801.9719309824128, 805.7139715400948, 811.7118422959883, 843.6456688190851, 864.8918885139358, 4386.210482113186, 4387.5393083726385, 4403.4495688039, 4413.7793110344355, 4413.911721765547, 5029.497050294941, 5047.318611987334, 5049.722265275372, 5100.546344291859, 5104.2088476286235, 4227.704060715781, 4354.738715677006, 4401.625861801783, 4417.359482875029, 4426.336049592523, 2751.2021513761188, 2751.931201719973, 2765.0, 2770.847603381793, 2777.069681656668, 4907.950920490821, 4935.679180853233, 4936.777844996912, 4951.183054795991, 4970.403551573762, 4970.776315065831, 5294.788208471695, 5296.973515132399, 5330.307060082165, 5366.517013468807, 4889.0, 4891.706497610155, 4900.324756432676, 4922.433920099163, 4930.778114984762, 5194.480551944926, 5207.765650545659, 5213.713245771519, 5223.817166399158, 5241.633085683966, 4943.431505376928, 5096.923546146885, 5120.667156634807, 5123.692578445305, 5142.562882155059, 4906.362172917497, 4911.263310503453, 4913.385826771653, 4917.278952366786, 4919.655624106278, 3681.1410237829723, 3681.631836816297, 3692.7968961707365, 3694.6674799268194, 3701.4077747561337, 4912.975435122801, 5153.7165455900285, 5236.219685307014, 5254.133068043883, 5255.658382205144, 5004.17431123875, 5008.474110218374, 5012.0, 5040.193569028937, 5043.798248070036, 4987.351644286219, 4999.150144475375, 5023.949760502348, 5028.145215313332, 5028.949710502994, 4806.158922188673, 4903.705777653352, 4936.950630493793, 4937.975310123426, 4946.455889852042, 4807.8989052061925, 4928.0, 5016.698998060128, 5064.290999260033, 5078.97460512695, 4842.201036828884, 4871.806407430202, 4878.975605122094, 4891.364122664173, 4910.950890491049], "value": 3776.9130607678076, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.2664802237315, 620.1070458539705, 634.6890023888295, 637.3690046853617, 637.4358692557089, 12276.754464910708, 13809.654758631039, 13840.653983650389, 13868.0, 13877.0, 12806.935965320185, 12984.220946743202, 12984.350782460886, 12991.935040324808, 13020.0, 635.5233574818886, 771.6604693934651, 804.4489524675587, 815.6941147069849, 817.4237162800212, 813.8494378539989, 816.4366587054943, 819.3117781063905, 819.3486178488116, 819.5164852736884, 845.1970627903486, 846.4836449765638, 851.4933614499394, 851.5316575883239, 851.7146755836802, 643.983900402489, 672.1329484964366, 672.3780503034674, 672.5493919074232, 845.71245776436, 592.1502643706252, 617.9196704428396, 621.0590954703628, 622.8816524860262, 623.3174673732256, 13135.146215495963, 13170.34148292591, 13172.341382930816, 13176.802347964789, 13187.340632968313, 12468.563600273947, 12797.296148711817, 12921.353932303442, 12928.40480890006, 12945.546905858344, 11454.828177577343, 11490.827637585442, 11506.88493115075, 11711.121665875009, 11798.528058877635, 4104.486939132608, 4218.8523401680795, 4279.5078565965005, 4299.312110062375, 4307.0, 55663.44336556623, 56478.87042259173, 57038.714806425705, 57103.0, 57142.428575714126, 10214.336068155546, 10292.897071029194, 10336.896631033744, 10489.055984961238, 10673.519691613896, 18738.531536711693, 18750.906245468686, 18754.0, 18754.343597974006, 18778.906105469658, 6376.458001069961, 6401.615903045832, 6434.163558737334, 6484.25431075423, 6557.7704780333415, 3715.554133503997, 3717.219383929405, 3767.6232376762105, 3817.2365526894732, 3966.8809935701975, 2812.31098380898, 2919.4307110113323, 2921.3134913295357, 2921.3719050404266, 2925.795194336376, 480.5026797264884, 481.85062630584633, 486.81501029608523, 487.20342240436435, 505.6031015652695, 512.0041519245107, 519.9584033277329, 557.1058451185869, 570.7117905457717, 575.9366469688331, 7876.448648594544, 7891.171427000198, 8044.597770111471, 8131.512109273463, 8147.83704325922, 490.4996903158758, 559.3371854352605, 562.7833284185618, 568.5650477384804, 571.274481408617, 3736.4582135590185, 3771.396576547794, 3779.773213607137, 3808.7524310919703, 3834.1181528248103, 83826.58086709527, 86232.0, 86836.13163868406, 90063.54968225116, 90922.54538727396, 49187.99999999929, 56628.71685641628, 66692.33307666959, 72929.0, 74135.25864741283, 68023.31976680268, 69697.30302696908, 69922.65038674774, 70008.0, 71658.28341716621, 7183.245759195209, 7288.08898887639, 7306.634668266672, 7330.45021623391, 7357.484976051625, 41560.584394155674, 42563.3615495774, 43182.35226471668, 43521.34717979296, 44016.77991610021, 58550.41449585449, 60428.79142417215, 60542.697286513285, 60610.93890610903, 60779.39220607738, 8690.78273043179, 9276.350655454053, 9411.952940235255, 9605.759856003655, 9635.0, 9702.272329575451, 10027.749306267402, 10372.688819335432, 10478.37129772216, 10542.420166890588, 7690.923090769021, 9115.316351273548, 9320.0, 11639.41802909868, 12177.147599667938, 11910.404479776149, 12135.817962730389, 12349.0, 12444.688882778002, 12485.636921355435, 11688.649340519798, 11799.0, 11935.224210426642, 12479.812802807783, 12506.74986500283, 9428.292878034312, 9864.506774661382, 9992.0, 10043.0, 10366.506219605215, 9869.901300986898, 10375.584976600852, 10376.221783366127, 10394.168466522811, 10403.53184106732], "value": 6350.189650806253, "unit": "score"}], "name": "dromaeo_css", "value": 6277.049938471165, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 114.0, 112.0, 113.0, 112.0, 112.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 131.0, 187.0, 129.0, 163.0, 155.0, 130.0, 194.0, 137.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 162.0, 159.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 131.0, 77.0, 77.0, 75.0, 77.0, 106.0, 76.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 114.0, 87.0, 87.0, 86.0, 135.0, 87.0, 87.0, 123.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 149.0, 145.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 67.0, 65.0, 64.0, 64.0, 63.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 84.0, 88.0, 84.0, 84.0, 84.0, 119.0, 84.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 135.0, 143.0, 143.0, 133.0, 131.0, 131.0, 133.0, 134.0, 143.0], "value": 136.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 169.0, 169.0, 170.0, 166.0, 166.0, 166.0, 169.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 69.0, 69.0, 74.0, 67.0, 67.0, 66.0, 65.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1554.8, "alertThreshold": 2.0}]} 14:51:28 INFO - Return code: 0 14:51:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:51:28 ERROR - # TBPL SUCCESS # 14:51:28 INFO - Running post-action listener: _resource_record_post_action 14:51:28 INFO - ##### 14:51:28 INFO - ##### Finished run-tests step (success) 14:51:28 INFO - ##### 14:51:28 INFO - Running post-run listener: _resource_record_post_run 14:51:28 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 16384; Write bytes: 528621568; Read time: 260; Write time: 452468 14:51:28 INFO - TinderboxPrint: CPU usage
13.1% 14:51:28 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 260 14:51:28 INFO - TinderboxPrint: I/O write bytes / time
528,621,568 / 452,468 14:51:28 INFO - TinderboxPrint: CPU idle
8,325.0 (86.9%) 14:51:28 INFO - TinderboxPrint: CPU user
1,210.1 (12.6%) 14:51:28 INFO - TinderboxPrint: Swap in / out
0 / 0 14:51:28 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246480896; Read time: 72; Write time: 248040 14:51:28 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 282140672; Read time: 188; Write time: 204428 14:51:29 INFO - Running post-run listener: _upload_blobber_files 14:51:29 INFO - Blob upload gear active. 14:51:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:51:29 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'] 14:51:29 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 14:51:29 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:51:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:51:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:32 INFO - (blobuploader) - INFO - Done attempting. 14:51:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:51:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:51:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:33 INFO - (blobuploader) - INFO - Done attempting. 14:51:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:51:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:51:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:34 INFO - (blobuploader) - INFO - Done attempting. 14:51:34 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:34 INFO - Return code: 0 14:51:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7c0694b2cc8cb24667f79009b313d5bf6ec845d7476af6551c1afe6dfd8030a14ffce86cbc018aecee6de3b5e64368fb7b55ba77b052f39d4f2969ec310d2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4805e4d81f8b812dd441ab7c6b50c82cdda0cd56a34c289922b449213778ed7800d5b96c549d51e052e00557aa2ed2bcf8a1c986f0e332847ca5dd603099ab3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/788cbc66b9d3a22ea0f5d6cd214e6e3651a98d438459cf5b5e78151ec75f0858d29611f6789987f0b8de1ce15d50455f358d691dfce8e80348194c3beb959c19"} 14:51:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:34 INFO - Contents: 14:51:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f7c0694b2cc8cb24667f79009b313d5bf6ec845d7476af6551c1afe6dfd8030a14ffce86cbc018aecee6de3b5e64368fb7b55ba77b052f39d4f2969ec310d2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4805e4d81f8b812dd441ab7c6b50c82cdda0cd56a34c289922b449213778ed7800d5b96c549d51e052e00557aa2ed2bcf8a1c986f0e332847ca5dd603099ab3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/788cbc66b9d3a22ea0f5d6cd214e6e3651a98d438459cf5b5e78151ec75f0858d29611f6789987f0b8de1ce15d50455f358d691dfce8e80348194c3beb959c19"} 14:51:34 INFO - Running post-run listener: copy_logs_to_upload_dir 14:51:34 INFO - Copying logs to upload dir... 14:51:34 INFO - mkdir: /builds/slave/test/build/upload/logs 14:51:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.982529 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-06-03 14:51:34.642091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:51:34.646203) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127 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/f7c0694b2cc8cb24667f79009b313d5bf6ec845d7476af6551c1afe6dfd8030a14ffce86cbc018aecee6de3b5e64368fb7b55ba77b052f39d4f2969ec310d2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4805e4d81f8b812dd441ab7c6b50c82cdda0cd56a34c289922b449213778ed7800d5b96c549d51e052e00557aa2ed2bcf8a1c986f0e332847ca5dd603099ab3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/788cbc66b9d3a22ea0f5d6cd214e6e3651a98d438459cf5b5e78151ec75f0858d29611f6789987f0b8de1ce15d50455f358d691dfce8e80348194c3beb959c19"} build_url:https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/e2YayE7TTnSJzbMgSqsqIg/artifacts/public/build/firefox-49.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/f7c0694b2cc8cb24667f79009b313d5bf6ec845d7476af6551c1afe6dfd8030a14ffce86cbc018aecee6de3b5e64368fb7b55ba77b052f39d4f2969ec310d2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4805e4d81f8b812dd441ab7c6b50c82cdda0cd56a34c289922b449213778ed7800d5b96c549d51e052e00557aa2ed2bcf8a1c986f0e332847ca5dd603099ab3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/788cbc66b9d3a22ea0f5d6cd214e6e3651a98d438459cf5b5e78151ec75f0858d29611f6789987f0b8de1ce15d50455f358d691dfce8e80348194c3beb959c19"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:51:34.671874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:51:34.672224) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464989416.746789-373757127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004732 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:51:34.757973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:51:34.758323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:51:34.758657) ========= ========= Total master_lag: 0.18 =========