builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1465257666.94 results: success (0) buildid: 20160606143009 builduid: 8127c73dd1ad473c89c4a483a6065172 revision: 883b0a89b3212b6b55b7e6fde69d0438c39899ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:06.942640) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:06.943145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:06.943443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:06.961750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:06.962133) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 17:01:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-06-06 17:01:07 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:07.046360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:07.049708) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:07.099343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:07.102728) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 883b0a89b3212b6b55b7e6fde69d0438c39899ff --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 883b0a89b3212b6b55b7e6fde69d0438c39899ff --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=14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 17:01:07,208 truncating revision to first 12 chars 2016-06-06 17:01:07,208 Setting DEBUG logging. 2016-06-06 17:01:07,208 attempt 1/10 2016-06-06 17:01:07,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/883b0a89b321?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 17:01:07,744 unpacking tar archive at: fx-team-883b0a89b321/testing/mozharness/ program finished with exit code 0 elapsedTime=0.881008 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:07.999451) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:08.000752) ========= script_repo_revision: 883b0a89b3212b6b55b7e6fde69d0438c39899ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:08.001138) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:08.001483) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:08.012980) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-06 17:01:08.013377) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:01:08 INFO - MultiFileLogger online at 20160606 17:01:08 in /builds/slave/test 17:01:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:01:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:01:08 INFO - {'append_to_log': False, 17:01:08 INFO - 'base_work_dir': '/builds/slave/test', 17:01:08 INFO - 'blob_upload_branch': 'Fx-Team', 17:01:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:01:08 INFO - 'branch': 'Fx-Team', 17:01:08 INFO - 'buildbot_json_path': 'buildprops.json', 17:01:08 INFO - 'config_files': ('talos/linux_config.py',), 17:01:08 INFO - 'default_actions': ('clobber', 17:01:08 INFO - 'read-buildbot-config', 17:01:08 INFO - 'download-and-extract', 17:01:08 INFO - 'populate-webroot', 17:01:08 INFO - 'create-virtualenv', 17:01:08 INFO - 'install', 17:01:08 INFO - 'run-tests'), 17:01:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:01:08 INFO - 'download_minidump_stackwalk': True, 17:01:08 INFO - 'download_symbols': 'ondemand', 17:01:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:01:08 INFO - 'tooltool.py': '/tools/tooltool.py', 17:01:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:01:08 INFO - '/tools/misc-python/virtualenv.py')}, 17:01:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:01:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:01:08 INFO - 'installer_path': 'installer.exe', 17:01:08 INFO - 'log_level': 'info', 17:01:08 INFO - 'log_name': 'talos', 17:01:08 INFO - 'log_to_console': True, 17:01:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:01:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:01:08 INFO - 'opt_config_files': (), 17:01:08 INFO - 'pip_index': False, 17:01:08 INFO - 'sps_profile': False, 17:01:08 INFO - 'sps_profile_interval': 0, 17:01:08 INFO - 'suite': 'dromaeojs-e10s', 17:01:08 INFO - 'system_bits': '32', 17:01:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:01:08 INFO - 'title': 'talos-linux64-ix-036', 17:01:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:01:08 INFO - 'use_talos_json': True, 17:01:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:01:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:01:08 INFO - 'work_dir': 'build'} 17:01:08 INFO - ##### 17:01:08 INFO - ##### Running clobber step. 17:01:08 INFO - ##### 17:01:08 INFO - Running pre-action listener: _resource_record_pre_action 17:01:08 INFO - Running main action method: clobber 17:01:08 INFO - rmtree: /builds/slave/test/build 17:01:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:01:08 INFO - Running post-action listener: _resource_record_post_action 17:01:08 INFO - ##### 17:01:08 INFO - ##### Finished clobber step (success) 17:01:08 INFO - ##### 17:01:08 INFO - ##### 17:01:08 INFO - ##### Running read-buildbot-config step. 17:01:08 INFO - ##### 17:01:08 INFO - Running pre-action listener: _resource_record_pre_action 17:01:08 INFO - Running main action method: read_buildbot_config 17:01:08 INFO - Using buildbot properties: 17:01:08 INFO - { 17:01:08 INFO - "project": "", 17:01:08 INFO - "product": "firefox", 17:01:08 INFO - "script_repo_revision": "production", 17:01:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:01:08 INFO - "repository": "", 17:01:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:01:08 INFO - "buildid": "20160606143009", 17:01:08 INFO - "pgo_build": "True", 17:01:08 INFO - "basedir": "/builds/slave/test", 17:01:08 INFO - "buildnumber": 428, 17:01:08 INFO - "slavename": "talos-linux64-ix-036", 17:01:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:01:08 INFO - "platform": "ubuntu64_hw", 17:01:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:01:08 INFO - "branch": "fx-team", 17:01:08 INFO - "repo_path": "integration/fx-team", 17:01:08 INFO - "revision": "883b0a89b3212b6b55b7e6fde69d0438c39899ff", 17:01:08 INFO - "stage_platform": "linux64-pgo", 17:01:08 INFO - "builduid": "8127c73dd1ad473c89c4a483a6065172", 17:01:08 INFO - "slavebuilddir": "test" 17:01:08 INFO - } 17:01:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:01:08 INFO - Running post-action listener: _resource_record_post_action 17:01:08 INFO - ##### 17:01:08 INFO - ##### Finished read-buildbot-config step (success) 17:01:08 INFO - ##### 17:01:08 INFO - ##### 17:01:08 INFO - ##### Running download-and-extract step. 17:01:08 INFO - ##### 17:01:08 INFO - Running pre-action listener: _resource_record_pre_action 17:01:08 INFO - Running main action method: download_and_extract 17:01:08 INFO - mkdir: /builds/slave/test/build/tests 17:01:08 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')]} 17:01:08 INFO - https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:01:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:09 INFO - Downloaded 1361 bytes. 17:01:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:01:09 INFO - Using the following test package requirements: 17:01:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:01:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:01:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'jsshell-linux-x86_64.zip'], 17:01:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:01:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:01:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:01:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:01:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:01:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:01:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:01:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:01: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')]} 17:01:09 INFO - https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:01:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:10 INFO - Downloaded 24443829 bytes. 17:01:10 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'] 17:01:10 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 17:01:11 INFO - Return code: 0 17:01:11 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 17:01: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')]} 17:01:11 INFO - https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:01:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:01:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:12 INFO - Downloaded 24443829 bytes. 17:01:12 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'] 17:01:12 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 17:01:14 INFO - Return code: 0 17:01:14 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')]} 17:01:14 INFO - https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:01:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:01:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:15 INFO - Downloaded 10833369 bytes. 17:01:15 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'] 17:01:15 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 17:01:15 INFO - Return code: 0 17:01:15 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')]} 17:01:15 INFO - https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:01:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BuYhmW1uR86CzUKJnQOqXA/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 17:01:16 INFO - Downloaded 59193531 bytes. 17:01:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:16 INFO - mkdir: /builds/slave/test/properties 17:01:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:01:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:01:16 INFO - Contents: 17:01:16 INFO - build_url:https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:01:17 INFO - Running post-action listener: _resource_record_post_action 17:01:17 INFO - Running post-action listener: set_extra_try_arguments 17:01:17 INFO - ##### 17:01:17 INFO - ##### Finished download-and-extract step (success) 17:01:17 INFO - ##### 17:01:17 INFO - ##### 17:01:17 INFO - ##### Running populate-webroot step. 17:01:17 INFO - ##### 17:01:17 INFO - Running pre-action listener: _resource_record_pre_action 17:01:17 INFO - Running main action method: populate_webroot 17:01:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:01:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:01:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:01:17 INFO - '--tppagecycles', 17:01:17 INFO - '7'], 17:01:17 INFO - 'tests': ['tsvgm']}}, 17:01:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:01:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:01:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:01:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:01:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:01:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:01:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['damp', 'tps']}, 17:01:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'tests': ['damp', 'tps']}, 17:01:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['dromaeo_dom']}, 17:01:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:01:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['a11yr', 17:01:17 INFO - 'ts_paint', 17:01:17 INFO - 'tpaint', 17:01:17 INFO - 'sessionrestore', 17:01:17 INFO - 'sessionrestore_no_auto_restore', 17:01:17 INFO - 'tabpaint']}, 17:01:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:01:17 INFO - 'ts_paint', 17:01:17 INFO - 'tpaint', 17:01:17 INFO - 'sessionrestore', 17:01:17 INFO - 'sessionrestore_no_auto_restore', 17:01:17 INFO - 'tabpaint']}, 17:01:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:01:17 INFO - 'ts_paint', 17:01:17 INFO - 'tpaint', 17:01:17 INFO - 'sessionrestore', 17:01:17 INFO - 'sessionrestore_no_auto_restore', 17:01:17 INFO - 'tabpaint']}, 17:01:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:01:17 INFO - 'ts_paint', 17:01:17 INFO - 'tpaint', 17:01:17 INFO - 'sessionrestore', 17:01:17 INFO - 'sessionrestore_no_auto_restore', 17:01:17 INFO - 'tabpaint']}, 17:01:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['a11yr', 17:01:17 INFO - 'ts_paint', 17:01:17 INFO - 'tpaint', 17:01:17 INFO - 'sessionrestore', 17:01:17 INFO - 'sessionrestore_no_auto_restore', 17:01:17 INFO - 'tabpaint']}, 17:01:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['a11yr', 17:01:17 INFO - 'ts_paint', 17:01:17 INFO - 'tpaint', 17:01:17 INFO - 'sessionrestore', 17:01:17 INFO - 'sessionrestore_no_auto_restore', 17:01:17 INFO - 'tabpaint']}, 17:01:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['tsvgx', 17:01:17 INFO - 'tsvgr_opacity', 17:01:17 INFO - 'tart', 17:01:17 INFO - 'tscrollx', 17:01:17 INFO - 'cart']}, 17:01:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:01:17 INFO - 'tsvgr_opacity', 17:01:17 INFO - 'tart', 17:01:17 INFO - 'tscrollx', 17:01:17 INFO - 'cart']}, 17:01:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'talos_options': ['--disable-e10s'], 17:01:17 INFO - 'tests': ['tp5o']}, 17:01:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'tests': ['tp5o']}, 17:01:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'talos_options': ['--disable-e10s', 17:01:17 INFO - '--xperf_path', 17:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:01:17 INFO - 'tests': ['tp5n']}, 17:01:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:01:17 INFO - 'talos_options': ['--xperf_path', 17:01:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:01:17 INFO - 'tests': ['tp5n']}}, 17:01:17 INFO - 'talos.zip': {'path': '', 17:01:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:01:17 INFO - Running post-action listener: _resource_record_post_action 17:01:17 INFO - ##### 17:01:17 INFO - ##### Finished populate-webroot step (success) 17:01:17 INFO - ##### 17:01:17 INFO - ##### 17:01:17 INFO - ##### Running create-virtualenv step. 17:01:17 INFO - ##### 17:01:17 INFO - Running pre-action listener: _resource_record_pre_action 17:01:17 INFO - Running main action method: create_virtualenv 17:01:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:01:17 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 17:01:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:01:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:01:17 INFO - Using real prefix '/usr' 17:01:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:01:18 INFO - Installing distribute.............................................................................................................................................................................................done. 17:01:20 INFO - Installing pip.................done. 17:01:20 INFO - Return code: 0 17:01:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:01: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')]} 17:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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')]} 17:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:20 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:20 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 17:01:20 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 17:01:20 INFO - Using env: {'DISPLAY': ':0', 17:01:20 INFO - 'HOME': '/home/cltbld', 17:01:20 INFO - 'LANG': 'en_US.UTF-8', 17:01:20 INFO - 'LANGUAGE': 'en_US:en', 17:01:20 INFO - 'LOGNAME': 'cltbld', 17:01:20 INFO - 'MAIL': '/var/mail/cltbld', 17:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:20 INFO - 'MOZ_NO_REMOTE': '1', 17:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:20 INFO - 'NO_EM_RESTART': '1', 17:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:20 INFO - 'PWD': '/builds/slave/test', 17:01:20 INFO - 'SHELL': '/bin/bash', 17:01:20 INFO - 'SHLVL': '1', 17:01:20 INFO - 'TERM': 'linux', 17:01:20 INFO - 'TMOUT': '86400', 17:01:20 INFO - 'USER': 'cltbld', 17:01:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:20 INFO - '_': '/tools/buildbot/bin/python'} 17:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:20 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 17:01:20 INFO - Cleaning up... 17:01:20 INFO - Return code: 0 17:01:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:01: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')]} 17:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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')]} 17:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:20 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:20 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 17:01:20 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 17:01:20 INFO - Using env: {'DISPLAY': ':0', 17:01:20 INFO - 'HOME': '/home/cltbld', 17:01:20 INFO - 'LANG': 'en_US.UTF-8', 17:01:20 INFO - 'LANGUAGE': 'en_US:en', 17:01:20 INFO - 'LOGNAME': 'cltbld', 17:01:20 INFO - 'MAIL': '/var/mail/cltbld', 17:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:20 INFO - 'MOZ_NO_REMOTE': '1', 17:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:20 INFO - 'NO_EM_RESTART': '1', 17:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:20 INFO - 'PWD': '/builds/slave/test', 17:01:20 INFO - 'SHELL': '/bin/bash', 17:01:20 INFO - 'SHLVL': '1', 17:01:20 INFO - 'TERM': 'linux', 17:01:20 INFO - 'TMOUT': '86400', 17:01:20 INFO - 'USER': 'cltbld', 17:01:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:20 INFO - '_': '/tools/buildbot/bin/python'} 17:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:20 INFO - Downloading/unpacking psutil>=3.1.1 17:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:01:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:01:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:22 INFO - Installing collected packages: psutil 17:01:22 INFO - Running setup.py install for psutil 17:01:22 INFO - building 'psutil._psutil_linux' extension 17:01:22 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 17:01:22 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 17:01:23 INFO - building 'psutil._psutil_posix' extension 17:01:23 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 17:01:23 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 17:01:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:23 INFO - Successfully installed psutil 17:01:23 INFO - Cleaning up... 17:01:23 INFO - Return code: 0 17:01:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:23 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:23 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 17:01:23 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 17:01:23 INFO - Using env: {'DISPLAY': ':0', 17:01:23 INFO - 'HOME': '/home/cltbld', 17:01:23 INFO - 'LANG': 'en_US.UTF-8', 17:01:23 INFO - 'LANGUAGE': 'en_US:en', 17:01:23 INFO - 'LOGNAME': 'cltbld', 17:01:23 INFO - 'MAIL': '/var/mail/cltbld', 17:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:23 INFO - 'MOZ_NO_REMOTE': '1', 17:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:23 INFO - 'NO_EM_RESTART': '1', 17:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:23 INFO - 'PWD': '/builds/slave/test', 17:01:23 INFO - 'SHELL': '/bin/bash', 17:01:23 INFO - 'SHLVL': '1', 17:01:23 INFO - 'TERM': 'linux', 17:01:23 INFO - 'TMOUT': '86400', 17:01:23 INFO - 'USER': 'cltbld', 17:01:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:23 INFO - '_': '/tools/buildbot/bin/python'} 17:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:01:23 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 17:01:23 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 17:01:23 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 17:01:23 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 17:01:23 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 17:01:23 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 17:01:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:01:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:01:25 INFO - Installing collected packages: mozsystemmonitor 17:01:25 INFO - Running setup.py install for mozsystemmonitor 17:01:25 INFO - Successfully installed mozsystemmonitor 17:01:25 INFO - Cleaning up... 17:01:25 INFO - Return code: 0 17:01:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:01: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')]} 17:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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')]} 17:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01: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', '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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:01: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 jsonschema==2.5.1 17:01:25 INFO - Using env: {'DISPLAY': ':0', 17:01:25 INFO - 'HOME': '/home/cltbld', 17:01:25 INFO - 'LANG': 'en_US.UTF-8', 17:01:25 INFO - 'LANGUAGE': 'en_US:en', 17:01:25 INFO - 'LOGNAME': 'cltbld', 17:01:25 INFO - 'MAIL': '/var/mail/cltbld', 17:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:25 INFO - 'MOZ_NO_REMOTE': '1', 17:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:25 INFO - 'NO_EM_RESTART': '1', 17:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:25 INFO - 'PWD': '/builds/slave/test', 17:01:25 INFO - 'SHELL': '/bin/bash', 17:01:25 INFO - 'SHLVL': '1', 17:01:25 INFO - 'TERM': 'linux', 17:01:25 INFO - 'TMOUT': '86400', 17:01:25 INFO - 'USER': 'cltbld', 17:01:25 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:25 INFO - '_': '/tools/buildbot/bin/python'} 17:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:25 INFO - Downloading/unpacking jsonschema==2.5.1 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:01:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01: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 17:01:27 INFO - Downloading functools32-3.2.3-2.tar.gz 17:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:01:27 INFO - warning: no files found matching '*.txt' 17:01:27 INFO - no previously-included directories found matching 'build' 17:01:27 INFO - no previously-included directories found matching 'dist' 17:01:27 INFO - no previously-included directories found matching '.git*' 17:01:27 INFO - Installing collected packages: jsonschema, functools32 17:01:28 INFO - Running setup.py install for functools32 17:01:28 INFO - warning: no files found matching '*.txt' 17:01:28 INFO - no previously-included directories found matching 'build' 17:01:28 INFO - no previously-included directories found matching 'dist' 17:01:28 INFO - no previously-included directories found matching '.git*' 17:01:28 INFO - Successfully installed jsonschema functools32 17:01:28 INFO - Cleaning up... 17:01:28 INFO - Return code: 0 17:01:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:28 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:28 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 17:01:28 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 17:01:28 INFO - Using env: {'DISPLAY': ':0', 17:01:28 INFO - 'HOME': '/home/cltbld', 17:01:28 INFO - 'LANG': 'en_US.UTF-8', 17:01:28 INFO - 'LANGUAGE': 'en_US:en', 17:01:28 INFO - 'LOGNAME': 'cltbld', 17:01:28 INFO - 'MAIL': '/var/mail/cltbld', 17:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:28 INFO - 'MOZ_NO_REMOTE': '1', 17:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:28 INFO - 'NO_EM_RESTART': '1', 17:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:28 INFO - 'PWD': '/builds/slave/test', 17:01:28 INFO - 'SHELL': '/bin/bash', 17:01:28 INFO - 'SHLVL': '1', 17:01:28 INFO - 'TERM': 'linux', 17:01:28 INFO - 'TMOUT': '86400', 17:01:28 INFO - 'USER': 'cltbld', 17:01:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:28 INFO - '_': '/tools/buildbot/bin/python'} 17:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:28 INFO - Downloading/unpacking blobuploader==1.2.4 17:01:28 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 17:01:28 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 17:01:28 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 17:01:28 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 17:01:28 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 17:01:28 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 17:01:30 INFO - Downloading blobuploader-1.2.4.tar.gz 17:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:01:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:01:30 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 17:01:30 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 17:01:30 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 17:01:30 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 17:01:30 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 17:01:30 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 17:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:01:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:01:30 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 17:01:30 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 17:01:30 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 17:01:30 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 17:01:30 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 17:01:30 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 17:01:31 INFO - Downloading docopt-0.6.1.tar.gz 17:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:01:31 INFO - Installing collected packages: blobuploader, requests, docopt 17:01:31 INFO - Running setup.py install for blobuploader 17:01:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:01:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:01:31 INFO - Running setup.py install for requests 17:01:31 INFO - Running setup.py install for docopt 17:01:31 INFO - Successfully installed blobuploader requests docopt 17:01:31 INFO - Cleaning up... 17:01:31 INFO - Return code: 0 17:01:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:01:31 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')]} 17:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:31 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')]} 17:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:31 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:31 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 17:01:31 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 17:01:31 INFO - Using env: {'DISPLAY': ':0', 17:01:31 INFO - 'HOME': '/home/cltbld', 17:01:31 INFO - 'LANG': 'en_US.UTF-8', 17:01:31 INFO - 'LANGUAGE': 'en_US:en', 17:01:31 INFO - 'LOGNAME': 'cltbld', 17:01:31 INFO - 'MAIL': '/var/mail/cltbld', 17:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:31 INFO - 'MOZ_NO_REMOTE': '1', 17:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:31 INFO - 'NO_EM_RESTART': '1', 17:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:31 INFO - 'PWD': '/builds/slave/test', 17:01:31 INFO - 'SHELL': '/bin/bash', 17:01:31 INFO - 'SHLVL': '1', 17:01:31 INFO - 'TERM': 'linux', 17:01:31 INFO - 'TMOUT': '86400', 17:01:31 INFO - 'USER': 'cltbld', 17:01:31 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:31 INFO - '_': '/tools/buildbot/bin/python'} 17:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:01:31 INFO - Running setup.py (path:/tmp/pip-AbRjhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:01:32 INFO - Running setup.py (path:/tmp/pip-0rlT2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:01:32 INFO - Running setup.py (path:/tmp/pip-B9sznC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:01:32 INFO - Running setup.py (path:/tmp/pip-lG0FQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:01:32 INFO - Running setup.py (path:/tmp/pip-6uTZUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:01:32 INFO - Running setup.py (path:/tmp/pip-59A8pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:01:32 INFO - Running setup.py (path:/tmp/pip-bghm6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:01:32 INFO - Running setup.py (path:/tmp/pip-TKEUa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:01:32 INFO - Running setup.py (path:/tmp/pip-t7i8CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:01:32 INFO - Running setup.py (path:/tmp/pip-IucIcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:01:32 INFO - Running setup.py (path:/tmp/pip-Oth2ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:01:32 INFO - Running setup.py (path:/tmp/pip-MNdXJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:01:32 INFO - Running setup.py (path:/tmp/pip-0YE0ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:01:32 INFO - Running setup.py (path:/tmp/pip-hrry3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:32 INFO - Running setup.py (path:/tmp/pip-gXnUcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:01:33 INFO - Running setup.py (path:/tmp/pip-Z1OPgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:01:33 INFO - Running setup.py (path:/tmp/pip-8if2DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:01:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:01:33 INFO - Running setup.py install for manifestparser 17:01:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:01:33 INFO - Running setup.py install for mozcrash 17:01:33 INFO - Running setup.py install for mozdebug 17:01:33 INFO - Running setup.py install for mozdevice 17:01:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:01:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:01:33 INFO - Running setup.py install for mozfile 17:01:33 INFO - Running setup.py install for mozhttpd 17:01:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:01:33 INFO - Running setup.py install for mozinfo 17:01:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:01:33 INFO - Running setup.py install for mozInstall 17:01:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Running setup.py install for mozleak 17:01:34 INFO - Running setup.py install for mozlog 17:01:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Running setup.py install for moznetwork 17:01:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Running setup.py install for mozprocess 17:01:34 INFO - Running setup.py install for mozprofile 17:01:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Running setup.py install for mozrunner 17:01:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Running setup.py install for mozscreenshot 17:01:34 INFO - Running setup.py install for moztest 17:01:34 INFO - Running setup.py install for mozversion 17:01:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:01:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:01:34 INFO - Cleaning up... 17:01:35 INFO - Return code: 0 17:01:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:01:35 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')]} 17:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:35 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')]} 17:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:35 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:35 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 17:01:35 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 17:01:35 INFO - Using env: {'DISPLAY': ':0', 17:01:35 INFO - 'HOME': '/home/cltbld', 17:01:35 INFO - 'LANG': 'en_US.UTF-8', 17:01:35 INFO - 'LANGUAGE': 'en_US:en', 17:01:35 INFO - 'LOGNAME': 'cltbld', 17:01:35 INFO - 'MAIL': '/var/mail/cltbld', 17:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:35 INFO - 'MOZ_NO_REMOTE': '1', 17:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:35 INFO - 'NO_EM_RESTART': '1', 17:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:35 INFO - 'PWD': '/builds/slave/test', 17:01:35 INFO - 'SHELL': '/bin/bash', 17:01:35 INFO - 'SHLVL': '1', 17:01:35 INFO - 'TERM': 'linux', 17:01:35 INFO - 'TMOUT': '86400', 17:01:35 INFO - 'USER': 'cltbld', 17:01:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:35 INFO - '_': '/tools/buildbot/bin/python'} 17:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:01:35 INFO - Running setup.py (path:/tmp/pip-MmZce2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:01:35 INFO - Running setup.py (path:/tmp/pip-hbPGb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:01:35 INFO - Running setup.py (path:/tmp/pip-GVdVuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:01:35 INFO - Running setup.py (path:/tmp/pip-EVZ4VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:01:35 INFO - Running setup.py (path:/tmp/pip-5jkw6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:01:35 INFO - Running setup.py (path:/tmp/pip-OzwvBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:01:35 INFO - Running setup.py (path:/tmp/pip-ER0RBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:01:35 INFO - Running setup.py (path:/tmp/pip-gBXx09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:01:35 INFO - Running setup.py (path:/tmp/pip-5JskOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:01:35 INFO - Running setup.py (path:/tmp/pip-QuPfW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:01:35 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)) 17:01:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:01:35 INFO - Running setup.py (path:/tmp/pip-R5j9YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:01:36 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)) 17:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:01:36 INFO - Running setup.py (path:/tmp/pip-viuQRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:01:36 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)) 17:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:01:36 INFO - Running setup.py (path:/tmp/pip-DHiv3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:01:36 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)) 17:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:01:36 INFO - Running setup.py (path:/tmp/pip-CA8kAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:01:36 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)) 17:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:36 INFO - Running setup.py (path:/tmp/pip-1kGr3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:01:36 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)) 17:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:01:36 INFO - Running setup.py (path:/tmp/pip-2FIU6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:01:36 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)) 17:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:01:36 INFO - Running setup.py (path:/tmp/pip-qxml3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:01:36 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)) 17:01:36 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)) 17:01:36 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)) 17:01:36 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)) 17:01:36 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)) 17:01:36 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)) 17:01:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:01:36 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 17:01:36 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 17:01:36 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 17:01:36 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 17:01:36 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 17:01:36 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 17:01:38 INFO - Downloading blessings-1.6.tar.gz 17:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:01:38 INFO - Installing collected packages: blessings 17:01:38 INFO - Running setup.py install for blessings 17:01:38 INFO - Successfully installed blessings 17:01:38 INFO - Cleaning up... 17:01:38 INFO - Return code: 0 17:01:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:01:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:01:38 INFO - Reading from file tmpfile_stdout 17:01:38 INFO - Current package versions: 17:01:38 INFO - argparse == 1.2.1 17:01:38 INFO - blessings == 1.6 17:01:38 INFO - blobuploader == 1.2.4 17:01:38 INFO - docopt == 0.6.1 17:01:38 INFO - functools32 == 3.2.3-2 17:01:38 INFO - jsonschema == 2.5.1 17:01:38 INFO - manifestparser == 1.1 17:01:38 INFO - mozInstall == 1.12 17:01:38 INFO - mozcrash == 0.17 17:01:38 INFO - mozdebug == 0.1 17:01:38 INFO - mozdevice == 0.48 17:01:38 INFO - mozfile == 1.2 17:01:38 INFO - mozhttpd == 0.7 17:01:38 INFO - mozinfo == 0.9 17:01:38 INFO - mozleak == 0.1 17:01:38 INFO - mozlog == 3.2 17:01:38 INFO - moznetwork == 0.27 17:01:38 INFO - mozprocess == 0.22 17:01:38 INFO - mozprofile == 0.28 17:01:38 INFO - mozrunner == 6.11 17:01:38 INFO - mozscreenshot == 0.1 17:01:38 INFO - mozsystemmonitor == 0.3 17:01:38 INFO - moztest == 0.7 17:01:38 INFO - mozversion == 1.4 17:01:38 INFO - psutil == 3.1.1 17:01:38 INFO - requests == 1.2.3 17:01:38 INFO - wsgiref == 0.1.2 17:01:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:38 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:38 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 17:01:38 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 17:01:38 INFO - Using env: {'DISPLAY': ':0', 17:01:38 INFO - 'HOME': '/home/cltbld', 17:01:38 INFO - 'LANG': 'en_US.UTF-8', 17:01:38 INFO - 'LANGUAGE': 'en_US:en', 17:01:38 INFO - 'LOGNAME': 'cltbld', 17:01:38 INFO - 'MAIL': '/var/mail/cltbld', 17:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:38 INFO - 'MOZ_NO_REMOTE': '1', 17:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:38 INFO - 'NO_EM_RESTART': '1', 17:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:38 INFO - 'PWD': '/builds/slave/test', 17:01:38 INFO - 'SHELL': '/bin/bash', 17:01:38 INFO - 'SHLVL': '1', 17:01:38 INFO - 'TERM': 'linux', 17:01:38 INFO - 'TMOUT': '86400', 17:01:38 INFO - 'USER': 'cltbld', 17:01:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:38 INFO - '_': '/tools/buildbot/bin/python'} 17:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 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)) 17:01:39 INFO - Cleaning up... 17:01:39 INFO - Return code: 0 17:01:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:39 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:39 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 17:01:39 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 17:01:39 INFO - Using env: {'DISPLAY': ':0', 17:01:39 INFO - 'HOME': '/home/cltbld', 17:01:39 INFO - 'LANG': 'en_US.UTF-8', 17:01:39 INFO - 'LANGUAGE': 'en_US:en', 17:01:39 INFO - 'LOGNAME': 'cltbld', 17:01:39 INFO - 'MAIL': '/var/mail/cltbld', 17:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:39 INFO - 'MOZ_NO_REMOTE': '1', 17:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:39 INFO - 'NO_EM_RESTART': '1', 17:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:39 INFO - 'PWD': '/builds/slave/test', 17:01:39 INFO - 'SHELL': '/bin/bash', 17:01:39 INFO - 'SHLVL': '1', 17:01:39 INFO - 'TERM': 'linux', 17:01:39 INFO - 'TMOUT': '86400', 17:01:39 INFO - 'USER': 'cltbld', 17:01:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:39 INFO - '_': '/tools/buildbot/bin/python'} 17:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:01:39 INFO - Cleaning up... 17:01:39 INFO - Return code: 0 17:01:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:39 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 0x7f3bf359cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', '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 17:01:39 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 17:01:39 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 17:01:39 INFO - Using env: {'DISPLAY': ':0', 17:01:39 INFO - 'HOME': '/home/cltbld', 17:01:39 INFO - 'LANG': 'en_US.UTF-8', 17:01:39 INFO - 'LANGUAGE': 'en_US:en', 17:01:39 INFO - 'LOGNAME': 'cltbld', 17:01:39 INFO - 'MAIL': '/var/mail/cltbld', 17:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:39 INFO - 'MOZ_NO_REMOTE': '1', 17:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:39 INFO - 'NO_EM_RESTART': '1', 17:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:39 INFO - 'PWD': '/builds/slave/test', 17:01:39 INFO - 'SHELL': '/bin/bash', 17:01:39 INFO - 'SHLVL': '1', 17:01:39 INFO - 'TERM': 'linux', 17:01:39 INFO - 'TMOUT': '86400', 17:01:39 INFO - 'USER': 'cltbld', 17:01:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:39 INFO - '_': '/tools/buildbot/bin/python'} 17:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:39 INFO - Downloading/unpacking flake8 17:01:39 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 17:01:39 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 17:01:39 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 17:01:39 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 17:01:39 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 17:01:39 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 17:01:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:01:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:01:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:41 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 17:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:01:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:01:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:01:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:01:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:01:42 INFO - no previously-included directories found matching 'docs/_build' 17:01:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:01:42 INFO - Running setup.py install for pep8 17:01:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:01:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:01:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:01:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:01:42 INFO - no previously-included directories found matching 'docs/_build' 17:01:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:01:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:01:42 INFO - Cleaning up... 17:01:42 INFO - Return code: 0 17:01:42 INFO - Running post-action listener: _resource_record_post_action 17:01:42 INFO - Running post-action listener: _start_resource_monitoring 17:01:42 INFO - Starting resource monitoring. 17:01:42 INFO - ##### 17:01:42 INFO - ##### Finished create-virtualenv step (success) 17:01:42 INFO - ##### 17:01:42 INFO - ##### 17:01:42 INFO - ##### Running install step. 17:01:42 INFO - ##### 17:01:42 INFO - Running pre-action listener: _resource_record_pre_action 17:01:42 INFO - Running main action method: install 17:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:01:42 INFO - Reading from file tmpfile_stdout 17:01:42 INFO - Detecting whether we're running mozinstall >=1.0... 17:01:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:01:42 INFO - Reading from file tmpfile_stdout 17:01:42 INFO - Output received: 17:01:42 INFO - Usage: mozinstall [options] installer 17:01:42 INFO - Options: 17:01:42 INFO - -h, --help show this help message and exit 17:01:42 INFO - -d DEST, --destination=DEST 17:01:42 INFO - Directory to install application into. [default: 17:01:42 INFO - "/builds/slave/test"] 17:01:42 INFO - --app=APP Application being installed. [default: firefox] 17:01:42 INFO - mkdir: /builds/slave/test/build/application 17:01:42 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'] 17:01:42 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 17:01:59 INFO - Reading from file tmpfile_stdout 17:01:59 INFO - Output received: 17:01:59 INFO - /builds/slave/test/build/application/firefox/firefox 17:01:59 INFO - Running post-action listener: _resource_record_post_action 17:01:59 INFO - ##### 17:01:59 INFO - ##### Finished install step (success) 17:01:59 INFO - ##### 17:01:59 INFO - ##### 17:01:59 INFO - ##### Running run-tests step. 17:01:59 INFO - ##### 17:01:59 INFO - Running pre-action listener: _resource_record_pre_action 17:01:59 INFO - Running main action method: run_tests 17:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:01:59 INFO - Python 2.7.3 17:01:59 INFO - Return code: 0 17:01:59 INFO - grabbing minidump binary from tooltool 17:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:01:59 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 0x12531c0>, '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 0x12540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1254550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:01:59 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 17:01:59 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 17:01:59 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 17:01:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:01:59 INFO - Return code: 0 17:01:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:01:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:01:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:01:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:01:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:01:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:01:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:02:00 INFO - Return code: 0 17:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:02:00 INFO - Using env: {'DISPLAY': ':0', 17:02:00 INFO - 'HOME': '/home/cltbld', 17:02:00 INFO - 'LANG': 'en_US.UTF-8', 17:02:00 INFO - 'LANGUAGE': 'en_US:en', 17:02:00 INFO - 'LOGNAME': 'cltbld', 17:02:00 INFO - 'MAIL': '/var/mail/cltbld', 17:02:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:02:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:00 INFO - 'MOZ_NO_REMOTE': '1', 17:02:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:00 INFO - 'NO_EM_RESTART': '1', 17:02:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:00 INFO - 'PWD': '/builds/slave/test', 17:02:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:02:00 INFO - 'SHELL': '/bin/bash', 17:02:00 INFO - 'SHLVL': '1', 17:02:00 INFO - 'TERM': 'linux', 17:02:00 INFO - 'TMOUT': '86400', 17:02:00 INFO - 'USER': 'cltbld', 17:02:00 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645', 17:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:00 INFO - '_': '/tools/buildbot/bin/python'} 17:02:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:02:00 INFO - mozversion application_buildid: 20160606143009 17:02:00 INFO - mozversion application_changeset: 883b0a89b3212b6b55b7e6fde69d0438c39899ff 17:02:00 INFO - mozversion application_display_name: Nightly 17:02:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:02:00 INFO - mozversion application_name: Firefox 17:02:00 INFO - mozversion application_remotingname: firefox 17:02:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:02:00 INFO - mozversion application_vendor: Mozilla 17:02:00 INFO - mozversion application_version: 49.0a1 17:02:00 INFO - mozversion platform_buildid: 20160606143009 17:02:00 INFO - mozversion platform_changeset: 883b0a89b3212b6b55b7e6fde69d0438c39899ff 17:02:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:02:00 INFO - mozversion platform_version: 49.0a1 17:02:00 INFO - using testdate: 1465257720 17:02:00 INFO - actual date: 1465257720 17:02:00 INFO - starting webserver on 'localhost:56605' 17:02:00 INFO - SUITE-START | Running 2 tests 17:02:00 INFO - TEST-START | dromaeo_css 17:02:00 INFO - operating with platform_type : linux_ 17:02:00 INFO - Initialising browser for dromaeo_css test... 17:02:00 INFO - TEST-INFO | started process 26587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQXciqc/profile http://localhost:56605/getInfo.html) 17:02:06 INFO - PROCESS | 26587 | __metrics Screen width/height:1600/1200 17:02:06 INFO - PROCESS | 26587 | colorDepth:24 17:02:06 INFO - PROCESS | 26587 | Browser inner width/height: 1024/697 17:02:06 INFO - PROCESS | 26587 | __metrics 17:02:07 ERROR - PROCESS | 26587 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 17:02:07 INFO - TEST-INFO | 26587: exit 0 17:02:07 INFO - Browser initialized. 17:02:07 INFO - Running cycle 1/1 for dromaeo_css test... 17:02:07 INFO - TEST-INFO | started process 26708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQXciqc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:19 INFO - PROCESS | 26708 | RSS: Main: 168058880 17:02:19 INFO - PROCESS | 26708 | 17:03:09 INFO - PROCESS | 26708 | 1465257789384 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] 17:05:16 INFO - PROCESS | 26708 | Cycle 1(1): loaded http://localhost:56605/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56605/tests/dromaeo/cssquery-ext.html) 17:05:17 INFO - PROCESS | 26708 | RSS: Main: 171294720 17:05:17 INFO - PROCESS | 26708 | 17:08:20 INFO - PROCESS | 26708 | Cycle 1(1): loaded http://localhost:56605/tests/dromaeo/cssquery-ext.html (next: http://localhost:56605/tests/dromaeo/cssquery-jquery.html) 17:08:20 INFO - PROCESS | 26708 | RSS: Main: 170561536 17:08:20 INFO - PROCESS | 26708 | 17:11:22 INFO - PROCESS | 26708 | Cycle 1(1): loaded http://localhost:56605/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56605/tests/dromaeo/cssquery-mootools.html) 17:11:23 INFO - PROCESS | 26708 | RSS: Main: 172281856 17:11:23 INFO - PROCESS | 26708 | 17:14:24 INFO - PROCESS | 26708 | Cycle 1(1): loaded http://localhost:56605/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56605/tests/dromaeo/cssquery-prototype.html) 17:14:25 INFO - PROCESS | 26708 | RSS: Main: 169287680 17:14:25 INFO - PROCESS | 26708 | 17:17:27 INFO - PROCESS | 26708 | Cycle 1(1): loaded http://localhost:56605/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56605/tests/dromaeo/cssquery-yui.html) 17:17:28 INFO - PROCESS | 26708 | RSS: Main: 171937792 17:17:28 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | Cycle 1(1): loaded http://localhost:56605/tests/dromaeo/cssquery-yui.html (next: http://localhost:56605/tests/dromaeo/cssquery-dojo.html) 17:20:31 INFO - PROCESS | 26708 | RSS: Main: 172359680 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | __start_tp_report 17:20:31 INFO - PROCESS | 26708 | _x_x_mozilla_page_load 17:20:31 INFO - PROCESS | 26708 | _x_x_mozilla_page_load_details 17:20:31 INFO - PROCESS | 26708 | |i|pagename|runs| 17:20:31 INFO - PROCESS | 26708 | |0;dojo.html;3140.5917230759997;3145.308032232908;3165.6834316568347;3172.9682703172975;3192.281736609263;5363.38321093074;5378.704171270583;5392.865178370543;5484.424135465769;5511.724413779315;5280.867978300545;5334.946650533493;5351.946480535194;5355.277037599923;5409.323834520685;4793.520647935205;4840.9515904840855;4990.351254336932;5052.115879721034;5094.261332106842;955.0448896802806;4986;4990.101781679296;5017.021680772251;5027.949720502785;5022.1211288024815;5040.445550989407;5042.218456139304;5051.217061355477;5081.085404627165;4867.294242334841;5007.749612519396;5043.394792624908;5063.518965698253;5072.315237442935;4869.172240719086;4948.554630083274;4953.752312384367;4957.603391728653;5015.598752099823;5295.708736019517;5307.177387504943;5328.760205790749;5332.3601167859715;5340.385855626575;5756.8848623027725;5793.826185214451;5837.708114594253;5874;5918.319393269786;5782.421757824226;5883.588148829541;5899.262592175978;5909.704514774287;5946.345901950782;5454.4545545445535;5494.725263736837;5495.725213739297;5501.614886957915;5509.531689806371;5866.2960444746905;5873.853153671193;5903.439173278532;5926.970365148233;5953.702314884238;5775.5668324875805;5804.071348584206;5807.361190269067;5809.244798176294;5843.620164689281;5857.7949771757785;5875.823725288163;5876.471117599436;5881.941180588139;5883.970580147157;5738.483536481736;5768.596198266081;5780.826575202751;5808.215890854765;5838.649681019152;5689.118186681071;5746.511546518593;5756.107803290497;5781.392953739881;5899.233099697012;4368.7815609219415;4382.627476664519;4407.074514352022;4417.3815665806815;4437.290033594674;3875.922481550353;3899.8440062397754;3902.941455878164;3929.960700393017;3948.7038472114705;5546.057170281062;5546.667199968015;5549.972250138723;5550.7779688812;5568.164775283659;5825.922204392201;5843.152742852262;5914.142449344821;5919.319278283053;5966.284045914518;5424.9421362834655;5453;5472.808451704172;5477.808276710376;5528.612997090246;4995.400551933792;5017.724025178577;5029.798808047711;5042.42012168598;5073.340465739504;5860.120981852756;5925.73334199962;5958.523318134538;6006.249218847644;6008.849778755479;5805.158252053428;5822.970885145547;5837.591368604157;5938.287405511193;5964.403559644001;6053.788117415869;6091.177691011834;6094.8171554853425;6112.022076467744;6120.663363515049;5689.601727879009;5743.655380677173;5799.304083509837;5804.158397032491;5827.300723912988;5858.765649373977;5973.880522389615;5974.850628734316;5983.9401605983385;6028.33688294296;5843;5855.443732845373;5856.619319744203;5856.912146317723;5863.648181109147;5571.025070612708;5664.093745000945;5673.120666296731;5775.27809023872;5810.593258471867;5436.7553460093595;5548;5592.049351610155;5596.356419011866;5664.405237450009;5752.395998420273;5759.337676167294;5790.710464476843;5793.884122317614;5806.796762113306;5522.66863988162;5562.777488900399;5631.774729010957;5685.232493613309;5686.545076393796 17:20:31 INFO - PROCESS | 26708 | |1;ext.html;579.4726798613262;608.7047781825815;610.6122612141289;621.5804332075849;622.5766478794424;41878;42926;42970;43093.56906430935;46621.76689116558;45540.08919821602;45853.77073114638;45916;46165.307520387134;46221.306680399735;8805.427647202927;8981.550922453884;9004.68483603074;9039.096090390942;9065.1388118129;8818.250448711868;8941.061188575204;8947.373683842134;8990.68532601359;9006.234470070052;8988.775280618003;8993;9060.682876099338;9064;9096.317776166781;8970.147835955606;8984.326175536828;9004.684836030707;9020.233280171193;9037.954810225972;8733.083026282213;8769.912300876973;8773.859398278248;8785.956070219672;8821.823563528758;42266.78866605678;42655.57344426578;42682.57317426817;42796.35805462921;42871.78564107191;3369.0398236502724;3442.431998720208;3508.122969257686;3549.716022718176;3757.2861156380472;30477.847610761804;32142.357152857046;32772.83613581941;32841;33674;4359.6948213625055;4456.502224261398;4493.990246915442;4541.45502539694;4552.772361381951;364068;364308;366196;367256;367436.16281918687;58604.41395586075;59013.70493147507;59062;59419;59547.702261489285;34824.30351392958;63562.36437635565;63721.362786371545;63905;64063.35936640667;16667.49997500077;17640.823591764176;17738.645227095385;17765.822341776675;17806.46580602584;13030.739385212242;13050;13136.146150500186;13145;13150;19130.330438434587;19225.807741922683;19254.326098586484;19278.518037048907;19304.71042934357;6856.6228857412325;7011.544249623758;7016.719331226694;7289.870070139137;7384.630768461556;952.3143336797494;1077.49357801833;1106.4965440724452;1111.3831823338126;1153.5904753812445;32408;32613.83693081567;32647.836760816517;32767.67232327694;32983;1106.7952428800697;1133.9603113890973;1134.585876155214;1158.5250047480492;1211.9575814846437;16402.671946561;17026.829731702524;17121;17139.334768322165;17209.397671081453;585128;587357;590259;591075;593317;56235.15647265294;57131.14303285371;57318.713406432704;57391;57421.13868291979;1350.743358761832;1368.568900796246;1371.6228037289625;1388.8541703121027;1395.6301580081285;30451;31633.683663163072;31683.683163168072;31840.363192735553;32425;50530.2420463686;50816;51003;51412;51462.22806657828;455212;466145;466675;467040;468247;27694;27860.16419507418;28056.29859253535;28104.71895281021;28142.43715125645;47276;47952.28071578999;48246.276305854735;49014.75492622514;49142.508574913794;40373.59626403816;40546.797266013484;40643.59356406398;40646;41819.58180418279;39420.60579394169;40012.799936000134;40393;40613.59386406098;40939.7953010233;39832.40670373268;40627.187456251304;40703.79648101741;41098.38352424776;41418.58581414147;33566;35551.46672799962;36117.09707257339;36177.45733814048;36213.818930905174;27546.86226568854;27606.5859012119;27699.86150069237;27847.16458506248;28065.71934280631 17:20:31 INFO - PROCESS | 26708 | |2;jquery.html;389.3497858576176;396.7698734733854;397.17784186733456;399.16176030336317;420.6928941872433;17987.910060449696;18655.3470628528;19357;19583.902080489595;19584.216631334748;17919.82080179198;18134.909325453355;18487.2605095796;18957.905210473964;19007.049647517604;5400.1629747389115;5573.832785016436;5778.8266352009505;5784.797532086378;5787.971060144693;5628.774849006056;5634.830955071334;5653.434656534334;5676.602637815355;5680.4319568043275;5406.810761623344;5592.888142237153;5708.97145514274;5726.770929162829;5740.225069615591;5690.573207009491;5694.77220911163;5698.686572238505;5704.458076482748;5719.28508936383;4933.950660493421;5105.846824595268;5129.9483605860705;5153.252778347119;5155.587552995751;21861.781382186135;22160.88919555392;22338.10647574095;22481;22506;2132.818710409617;2342.273895092527;2406.831521793475;2413.8310318277727;2515.2705715342527;9400.905990940071;9612.423254604746;10318.432486213254;10380.32527885685;10385.79228415435;1834.3763120539081;1899.591587808614;1926.2391355414672;1978.4163671716879;2001.1195074167465;65308;82493;82839.58580207061;83072;85178;10658.200634952409;10808.51361688726;11121.499532521057;11143.387113708663;11424.865296348067;15375.384984600714;15410.768838467431;15453.150076745887;15478.303476343592;15527;8138.674453021813;8266.628001739817;8311.625976830936;8472.788180295542;8497.192766687154;8050.879236811453;8148.10370859205;8185.836283274301;8338.291245244221;8356.415050946376;4707.8587642370785;4751.691140075884;4801.975990120027;4808.326834243208;4867.440244371872;1901.6386886491523;1968.6161198566142;1972.5068732816796;2028.949276268105;2082.9687554686693;927.638221093774;946.8721722567366;998.236349192868;1005.261133067195;1038.7506998320348;18297.26810927548;18613;18618.627627447648;18886.43340699781;18994.525136871413;1000.9049140331657;1005.7586179316911;1008.4755926917961;1020.6019652335596;1087.896649818266;5978.970105149447;6184.103305020837;10149;10592.311499752492;10687.83968240477;301204;301452;383323;457395;515609;64465;79096.6045169782;80912.59543702361;91412;96186;482.4524165072598;493.1370102320938;495.14587336844374;497.1449107535034;498.27003439960635;9977.201823854219;10550;10789.784204316027;11534.769304613694;11594.76810463803;40703.79648101741;42269;44968.77515612401;45606.54393456023;46679.29981050219;61621.69189154205;62499.37500624936;62616.37383626105;63016.05475917957;63098.36901631109;8285.337173026264;8680.218780309802;8694.17405346491;8723.781905452415;8879.200871921557;11435.485403157045;13026.80459793085;13066.477340906258;13172.275524845842;13294.135881167693;11160.218784684994;11190.776184476103;11217.71955701114;11292.040176585082;11551.653450396501;11338.546458141582;11461.426928653367;11503;11650.41747912618;11688.532458701897;10917.290376125526;11126;11397.829032564685;11530.192886497865;11564.595239166589;8904.332175086765;11039.944800275947;11583.884161158281;12071.517139314328;12594.811077833656;11002.449877505933;11411.372374519482;11426.085913127095;11829.112816538965;12054.578089766816 17:20:31 INFO - PROCESS | 26708 | |3;mootools.html;1460.014490219102;1488.8138982627172;1620.424749214029;1742.4249997500826;1767.3549154558582;7786.805329866742;8331.95834020829;8403.369747268956;8906.554672266386;8911.509866957314;8502.91497085029;8710.172533609313;8726.083761205076;8740.912590874104;8782.38523303369;2372.2290255666935;2380.7262164851004;2395.760423957599;2403.0748161957686;2403.146882856587;2315.5947709150832;2339.0526836631107;2383.95232095358;2387.868667223302;2390.964135537968;2361.1853910400882;2361.4686695493547;2368.3605426534828;2373.4303767095944;2388.5103553771437;2258;2269.1944359752297;2273.7271527416733;2273.9317820465412;2293.2546922250335;2278.157081879715;2284.0521183708743;2285.360099172218;2287;2297.7587353327995;8697.565121743888;8751.737447876574;8763.737087887373;8764;8767;5130.871728206787;5247.527722504993;5339.652922560022;5367.946320536784;5373.408925018245;3338.2822693121097;3456.9827150864085;3479.0780443182575;3563.5901871284873;3568.928621427583;1150.71232191952;1195.3664557784389;1226.129448091856;1238.1704258147063;1241.453760345445;11759;11847.703807404798;11870.109741769402;11887.346195959219;11926.701832454171;4635.605973492224;4689.95310046902;4761.642876784255;4786.2581299898575;4791.353167322367;10160.949195253976;10162.39025658463;10181.847272290921;10213.642522511676;10223.131033862204;5278.5249327560705;5326.36083669962;5339.119045357473;5341.519263266325;5351.063563876306;4370.584794444522;4748.121597504472;4850.733209673432;4883.633727470454;4917.852464426073;3989.162275922089;4022.35642297231;4111.568285330057;4147.170565886835;4172.666186705056;1291.9031072669588;1301.7136230029378;1317.2030921292671;1333.2267284974885;1344.1196016609138;901.6123067081218;1012.6455740490769;1015.4821041269006;1016.5832008876325;1028.93311934724;5954.970225148846;5999.880002399927;6008.158857759917;6014.488768454643;6168.845778855475;463.2610985478157;471.4935780182353;475.4769753271374;482.6356101143614;485.6042325504702;4076.164386300801;4203.726757760735;4211.136716973013;4216.599423054805;4248.723832950848;10245.7438564035;10776.29954052984;10806.189535784848;10841.07850832688;10894.40080795548;10218.437985910847;10589;10607.734806629896;10782.353058816496;10946.288491248044;8078.313343365762;8228.547429891294;8230.382721295926;8260.876086858581;8291.253787159185;6056.757729690763;6228.968855155696;6272.905906411499;6291.528135389773;6316.778912738216;9907.356021858555;9945.701628951143;9952.651657191964;9966;9966.950165249127;9570.47362395075;9889.50552472388;9923.305368624127;10071.244656650633;10201.744956375853;7041.683124259318;7651.1583725789005;7783;7832.960835195788;8014.759557213293;8088.474249173785;8352.248297653241;8363.916360836314;8378.329733621174;8453.196946290092;7391.482596218213;7641.1212710539;7642.541447513167;7698.92301076982;7714.305712485903;7023.47323950716;7059.011738356531;7100.502964792415;7133.215346312006;7317.5609463432365;6686.7993960181275;6791;6851.657417129024;6859.005444210661;6863.347981941708;4954.801807927643;5070.41690205631;5155.046316431472;5201.81793637236;5303.7878484860175;4923.876903077452;5022.447530771539;5102.4642412546145;5119.436861945109;5149.201873709581 17:20:31 INFO - PROCESS | 26708 | |4;prototype.html;311.9422906762249;320.4040484698462;321.3492677328411;327.8459124211621;328.6795374509853;5375.865603359918;5431;5503.807366742165;5610.625396777785;5645.9554982328245;5479.808206712766;5511.862203444916;5516.565692919839;5537.778488860441;5565.972170139144;4302.290122129861;4312.417823593806;4312.439382880221;4328.307470804664;4350.782460876943;4150.97924510377;4333.306670932651;4340.804663790122;4350.630196433307;4351.608355248027;4241.300185469409;4282.700210985232;4285.657147428198;4286.142771445708;4296.806643701041;4228.809703563347;4268.551802060801;4299.097189590189;4305.117450922553;4325.091730736549;3655.232401195752;3829.2341531693496;3836.5037635322246;3852.6917846572205;3861.2470568238923;5269.55208807248;5323.760430780624;5327.334083239595;5330.866728331784;5354.527504936134;4945.120854075464;4977.601791856643;4990.975045124787;5001.249812528114;5006.6245031622775;5620.887582248332;5834.241548598655;5837.678927658977;5898.262717160355;5902.734376953004;4142.514491305223;4183.226103170923;4194.406125672255;4205.11692544566;4211.789410529461;6041.395860413967;6042.428968468186;6061.696915154269;6083.479130217445;6109.847253818646;4076.9592304076577;4294.806733696991;4333;4334.848280310174;4343.04453020335;4405.427294451701;4407.272799987966;4411.514733379326;4431.379606855043;4434.26834572292;4998;5014.498550145029;5025.120603894377;5032.597392208614;5033.0940430722085;5739.454751798572;5889.38161493037;5918.704064796743;5920.259967504062;5968.850778730566;1494.4321157960123;1501.8648321651103;1507.4648499782638;1509.7207016701946;1517.3020410611023;936.2977766674994;974.4396971741277;977.4526265291317;981.6613268422383;984.5028260728429;4983.6013118950395;5006.4743201964;5068.974655126701;5078.060558796635;5134.460881607452;5324.760385782649;5327.334083239595;5332.626716129834;5336.279602253724;5394.649347792381;4838.685485443435;4968.30443737877;4976.8755781105765;5078.187490001582;5110.6678065926335;2858.2568532181367;2861.4563232985665;2876.3240638449947;2886.6536015678253;2914.1932002158796;5509.283793106951;5514.696691681996;5518.475744804237;5526.4197259288;5592.266397416814;5327.653702509402;5404.189371594213;5444.4211178758505;5473.972630136904;5528.612997090165;5351.598630102758;5505.862353441196;5532.3914369419335;5534.8653526027065;5555.722213889289;5278.419373868948;5305.779670675844;5358.544523715528;5387.703676297841;5537.4495141360485;5967.701614919323;5985.700714964148;5994.400559943971;6029.939700602938;6030.155778190969;5898.380670029585;6277.435030847246;6279.560430769802;6284.277308109626;6287.591306565241;4051.513818341818;4116.991337122424;4160.3343465046655;4162.105147393325;4185.518665353523;5929.407059294036;5936.13925980739;5949.315828679584;6008.008678567988;6039.818805435844;5704.258446401941;5757.251557297692;5776.7111644418455;5794.449527294901;5817.331006934257;5731.398203188772;5739.397363276963;5748.195252664714;5756.301890942098;5786.392428794916;5639.561911712487;5654.123610840326;5656.547476201977;5658.490735833795;5681.517071049007;5581.49766521015;5837.211976383134;5847.883042339215;5847.94152058491;5860.501857342174;5610.579206559442;5663.235463212413;5693.117566777156;5693.28833895763;5714.428557144252 17:20:31 INFO - PROCESS | 26708 | |5;yui.html;792.6564473217896;809.2716555100412;825.0264687668556;830.5224495914848;836.289154218914;14560.126392416463;14652.926735366322;14800.333984970675;14924.179170145637;15204.923975380121;15763.527094187193;16340.428085017027;16348.75476867848;16975.57561060974;17032.063236521986;791.8218400859818;804.4811096842533;805.3235282362814;806.4999700185864;806.8587997100514;672.9360710732496;773.9729109481169;790.7746292306693;794.6900708723573;796.1043825696092;837.6481877611387;842.5618678287318;842.7935155886817;844.9704260350858;847.3602430165216;836.9455985360933;837.6481877611418;839.1105428246049;840.1892174052039;840.2018082821344;610.0270069239556;613.3927411862269;616.0205273614973;616.2881871438495;618.5330075792748;15579.688406231811;15635.218239088;15674.9216253918;15704.921475392664;15722.921385393114;14191.78712319316;14598.92700536501;14641.853581464156;14674.486392976301;14934.775978360334;11948.342841143734;12095.758084838342;12130.696732581668;12251;12323.568675096329;3682.9263414731554;3721.4789929409903;3724.7578907371203;3808.447775072599;3869.1294458746556;79490.60254698689;80031;81451;81525;82780.58609706972;11472.885271147348;11674.591389301333;11741.29552226869;11754.588589399329;11806.940965295118;20404;21238.46903827417;21307;21334.253301134697;21431.249906253517;8402.537860417735;8802.383833131747;8832.91167088321;8859.424137431046;8920.687775927941;5030.170021946411;5059.64357931029;5066.771995260222;5084;5141.460146684619;3591.982040089783;3606.693431058337;3655.287218992271;3669.174435751988;3719.497867787868;600.5975996082635;614.4961131871911;615.0958091605333;622.7011034703277;623.8440389902524;738.811603041221;738.8226825561934;744.162816831065;749.1609397474754;799.7320897499286;9011.549422528979;9340.71977840666;9388.812223755624;9421.293402994803;9557.617695292249;693.9236683964759;740.9848507544698;754.3663322808867;761.9580923049285;778.8753799392183;4318.935215971763;4371.562843715603;4439.955600444019;4453.376527286183;4474.6867719259335;106834;107143;112522;112803.4359828212;115911.42044289724;95075.52462237644;100602.49698751606;101251.49374253082;101689;103232.48383758034;76895.61552192204;78945.60527197442;88338.55830720934;89372;90258;8864.911350886667;9655.710328690151;10408.947955260175;10429.478526073817;10517.579296828042;38280.42579361256;51043.744781275855;52191.47808522018;53244;54397.45602543924;70908.64545677445;77627.61186194033;78033.2196678026;78146;79108.60445697735;12691.682707932006;12845.550405735754;12924.676883077998;12989.610311690665;13203;14640.633984150481;15011.249437527862;15158.31787569584;15505.379784808933;15549.455769048029;14209.928950355183;14292.928535357256;14341.78487322712;14476.638084047983;14645.48740794067;13996.46528763124;14285.500007499688;14323.928380358031;14385.136891786526;14566.271686415424;13680.110792798436;13714.593580700483;14112.435502580192;14125.293735313398;14547.709045819236;10191.184705223712;10687.659870365434;11681.707957301136;11816.986980781154;12199.817002744789;11080.722981925517;11311;11523.711907202387;11631.59289424866;11700.239484433485 17:20:31 INFO - PROCESS | 26708 | __end_tp_report 17:20:31 INFO - PROCESS | 26708 | __start_cc_report 17:20:31 INFO - PROCESS | 26708 | _x_x_mozilla_cycle_collect,358 17:20:31 INFO - PROCESS | 26708 | __end_cc_report 17:20:31 INFO - PROCESS | 26708 | __startTimestamp1465258831448__endTimestamp 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | ------- Summary: start ------- 17:20:31 INFO - PROCESS | 26708 | Number of tests: 6 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | [#0] dojo.html Cycles:165 Average:5400.45 Median:5664.09 stddev:716.09 (12.6%) stddev-sans-first:696.00 17:20:31 INFO - PROCESS | 26708 | Values: 3140.6 3145.3 3165.7 3173.0 3192.3 5363.4 5378.7 5392.9 5484.4 5511.7 5280.9 5334.9 5351.9 5355.3 5409.3 4793.5 4841.0 4990.4 5052.1 5094.3 955.0 4986.0 4990.1 5017.0 5027.9 5022.1 5040.4 5042.2 5051.2 5081.1 4867.3 5007.7 5043.4 5063.5 5072.3 4869.2 4948.6 4953.8 4957.6 5015.6 5295.7 5307.2 5328.8 5332.4 5340.4 5756.9 5793.8 5837.7 5874.0 5918.3 5782.4 5883.6 5899.3 5909.7 5946.3 5454.5 5494.7 5495.7 5501.6 5509.5 5866.3 5873.9 5903.4 5927.0 5953.7 5775.6 5804.1 5807.4 5809.2 5843.6 5857.8 5875.8 5876.5 5881.9 5884.0 5738.5 5768.6 5780.8 5808.2 5838.6 5689.1 5746.5 5756.1 5781.4 5899.2 4368.8 4382.6 4407.1 4417.4 4437.3 3875.9 3899.8 3902.9 3930.0 3948.7 5546.1 5546.7 5550.0 5550.8 5568.2 5825.9 5843.2 5914.1 5919.3 5966.3 5424.9 5453.0 5472.8 5477.8 5528.6 4995.4 5017.7 5029.8 5042.4 5073.3 5860.1 5925.7 5958.5 6006.2 6008.8 5805.2 5823.0 5837.6 5938.3 5964.4 6053.8 6091.2 6094.8 6112.0 6120.7 5689.6 5743.7 5799.3 5804.2 5827.3 5858.8 5973.9 5974.9 5983.9 6028.3 5843.0 5855.4 5856.6 5856.9 5863.6 5571.0 5664.1 5673.1 5775.3 5810.6 5436.8 5548.0 5592.0 5596.4 5664.4 5752.4 5759.3 5790.7 5793.9 5806.8 5522.7 5562.8 5631.8 5685.2 5686.5 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | [#1] ext.html Cycles:180 Average:62953.00 Median:42072.39 stddev:128166.85 (304.6%) stddev-sans-first:128440.83 17:20:31 INFO - PROCESS | 26708 | Values: 579.5 608.7 610.6 621.6 622.6 41878.0 42926.0 42970.0 43093.6 46621.8 45540.1 45853.8 45916.0 46165.3 46221.3 8805.4 8981.6 9004.7 9039.1 9065.1 8818.3 8941.1 8947.4 8990.7 9006.2 8988.8 8993.0 9060.7 9064.0 9096.3 8970.1 8984.3 9004.7 9020.2 9038.0 8733.1 8769.9 8773.9 8786.0 8821.8 42266.8 42655.6 42682.6 42796.4 42871.8 3369.0 3442.4 3508.1 3549.7 3757.3 30477.8 32142.4 32772.8 32841.0 33674.0 4359.7 4456.5 4494.0 4541.5 4552.8 364068.0 364308.0 366196.0 367256.0 367436.2 58604.4 59013.7 59062.0 59419.0 59547.7 34824.3 63562.4 63721.4 63905.0 64063.4 16667.5 17640.8 17738.6 17765.8 17806.5 13030.7 13050.0 13136.1 13145.0 13150.0 19130.3 19225.8 19254.3 19278.5 19304.7 6856.6 7011.5 7016.7 7289.9 7384.6 952.3 1077.5 1106.5 1111.4 1153.6 32408.0 32613.8 32647.8 32767.7 32983.0 1106.8 1134.0 1134.6 1158.5 1212.0 16402.7 17026.8 17121.0 17139.3 17209.4 585128.0 587357.0 590259.0 591075.0 593317.0 56235.2 57131.1 57318.7 57391.0 57421.1 1350.7 1368.6 1371.6 1388.9 1395.6 30451.0 31633.7 31683.7 31840.4 32425.0 50530.2 50816.0 51003.0 51412.0 51462.2 455212.0 466145.0 466675.0 467040.0 468247.0 27694.0 27860.2 28056.3 28104.7 28142.4 47276.0 47952.3 48246.3 49014.8 49142.5 40373.6 40546.8 40643.6 40646.0 41819.6 39420.6 40012.8 40393.0 40613.6 40939.8 39832.4 40627.2 40703.8 41098.4 41418.6 33566.0 35551.5 36117.1 36177.5 36213.8 27546.9 27606.6 27699.9 27847.2 28065.7 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | [#2] jquery.html Cycles:180 Average:25884.13 Median:151859.64 stddev:66689.62 (43.9%) stddev-sans-first:66849.23 17:20:31 INFO - PROCESS | 26708 | Values: 389.3 396.8 397.2 399.2 420.7 17987.9 18655.3 19357.0 19583.9 19584.2 17919.8 18134.9 18487.3 18957.9 19007.0 5400.2 5573.8 5778.8 5784.8 5788.0 5628.8 5634.8 5653.4 5676.6 5680.4 5406.8 5592.9 5709.0 5726.8 5740.2 5690.6 5694.8 5698.7 5704.5 5719.3 4934.0 5105.8 5129.9 5153.3 5155.6 21861.8 22160.9 22338.1 22481.0 22506.0 2132.8 2342.3 2406.8 2413.8 2515.3 9400.9 9612.4 10318.4 10380.3 10385.8 1834.4 1899.6 1926.2 1978.4 2001.1 65308.0 82493.0 82839.6 83072.0 85178.0 10658.2 10808.5 11121.5 11143.4 11424.9 15375.4 15410.8 15453.2 15478.3 15527.0 8138.7 8266.6 8311.6 8472.8 8497.2 8050.9 8148.1 8185.8 8338.3 8356.4 4707.9 4751.7 4802.0 4808.3 4867.4 1901.6 1968.6 1972.5 2028.9 2083.0 927.6 946.9 998.2 1005.3 1038.8 18297.3 18613.0 18618.6 18886.4 18994.5 1000.9 1005.8 1008.5 1020.6 1087.9 5979.0 6184.1 10149.0 10592.3 10687.8 301204.0 301452.0 383323.0 457395.0 515609.0 64465.0 79096.6 80912.6 91412.0 96186.0 482.5 493.1 495.1 497.1 498.3 9977.2 10550.0 10789.8 11534.8 11594.8 40703.8 42269.0 44968.8 45606.5 46679.3 61621.7 62499.4 62616.4 63016.1 63098.4 8285.3 8680.2 8694.2 8723.8 8879.2 11435.5 13026.8 13066.5 13172.3 13294.1 11160.2 11190.8 11217.7 11292.0 11551.7 11338.5 11461.4 11503.0 11650.4 11688.5 10917.3 11126.0 11397.8 11530.2 11564.6 8904.3 11039.9 11583.9 12071.5 12594.8 11002.4 11411.4 11426.1 11829.1 12054.6 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | [#3] mootools.html Cycles:180 Average:5738.10 Median:2636.99 stddev:3210.73 (121.8%) stddev-sans-first:3203.64 17:20:31 INFO - PROCESS | 26708 | Values: 1460.0 1488.8 1620.4 1742.4 1767.4 7786.8 8332.0 8403.4 8906.6 8911.5 8502.9 8710.2 8726.1 8740.9 8782.4 2372.2 2380.7 2395.8 2403.1 2403.1 2315.6 2339.1 2384.0 2387.9 2391.0 2361.2 2361.5 2368.4 2373.4 2388.5 2258.0 2269.2 2273.7 2273.9 2293.3 2278.2 2284.1 2285.4 2287.0 2297.8 8697.6 8751.7 8763.7 8764.0 8767.0 5130.9 5247.5 5339.7 5367.9 5373.4 3338.3 3457.0 3479.1 3563.6 3568.9 1150.7 1195.4 1226.1 1238.2 1241.5 11759.0 11847.7 11870.1 11887.3 11926.7 4635.6 4690.0 4761.6 4786.3 4791.4 10160.9 10162.4 10181.8 10213.6 10223.1 5278.5 5326.4 5339.1 5341.5 5351.1 4370.6 4748.1 4850.7 4883.6 4917.9 3989.2 4022.4 4111.6 4147.2 4172.7 1291.9 1301.7 1317.2 1333.2 1344.1 901.6 1012.6 1015.5 1016.6 1028.9 5955.0 5999.9 6008.2 6014.5 6168.8 463.3 471.5 475.5 482.6 485.6 4076.2 4203.7 4211.1 4216.6 4248.7 10245.7 10776.3 10806.2 10841.1 10894.4 10218.4 10589.0 10607.7 10782.4 10946.3 8078.3 8228.5 8230.4 8260.9 8291.3 6056.8 6229.0 6272.9 6291.5 6316.8 9907.4 9945.7 9952.7 9966.0 9967.0 9570.5 9889.5 9923.3 10071.2 10201.7 7041.7 7651.2 7783.0 7833.0 8014.8 8088.5 8352.2 8363.9 8378.3 8453.2 7391.5 7641.1 7642.5 7698.9 7714.3 7023.5 7059.0 7100.5 7133.2 7317.6 6686.8 6791.0 6851.7 6859.0 6863.3 4954.8 5070.4 5155.0 5201.8 5303.8 4923.9 5022.4 5102.5 5119.4 5149.2 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | [#4] prototype.html Cycles:180 Average:4774.68 Median:5343.94 stddev:1389.22 (26.0%) stddev-sans-first:1352.13 17:20:31 INFO - PROCESS | 26708 | Values: 311.9 320.4 321.3 327.8 328.7 5375.9 5431.0 5503.8 5610.6 5646.0 5479.8 5511.9 5516.6 5537.8 5566.0 4302.3 4312.4 4312.4 4328.3 4350.8 4151.0 4333.3 4340.8 4350.6 4351.6 4241.3 4282.7 4285.7 4286.1 4296.8 4228.8 4268.6 4299.1 4305.1 4325.1 3655.2 3829.2 3836.5 3852.7 3861.2 5269.6 5323.8 5327.3 5330.9 5354.5 4945.1 4977.6 4991.0 5001.2 5006.6 5620.9 5834.2 5837.7 5898.3 5902.7 4142.5 4183.2 4194.4 4205.1 4211.8 6041.4 6042.4 6061.7 6083.5 6109.8 4077.0 4294.8 4333.0 4334.8 4343.0 4405.4 4407.3 4411.5 4431.4 4434.3 4998.0 5014.5 5025.1 5032.6 5033.1 5739.5 5889.4 5918.7 5920.3 5968.9 1494.4 1501.9 1507.5 1509.7 1517.3 936.3 974.4 977.5 981.7 984.5 4983.6 5006.5 5069.0 5078.1 5134.5 5324.8 5327.3 5332.6 5336.3 5394.6 4838.7 4968.3 4976.9 5078.2 5110.7 2858.3 2861.5 2876.3 2886.7 2914.2 5509.3 5514.7 5518.5 5526.4 5592.3 5327.7 5404.2 5444.4 5474.0 5528.6 5351.6 5505.9 5532.4 5534.9 5555.7 5278.4 5305.8 5358.5 5387.7 5537.4 5967.7 5985.7 5994.4 6029.9 6030.2 5898.4 6277.4 6279.6 6284.3 6287.6 4051.5 4117.0 4160.3 4162.1 4185.5 5929.4 5936.1 5949.3 6008.0 6039.8 5704.3 5757.3 5776.7 5794.4 5817.3 5731.4 5739.4 5748.2 5756.3 5786.4 5639.6 5654.1 5656.5 5658.5 5681.5 5581.5 5837.2 5847.9 5847.9 5860.5 5610.6 5663.2 5693.1 5693.3 5714.4 17:20:31 INFO - PROCESS | 26708 | 17:20:31 INFO - PROCESS | 26708 | [#5] yui.html Cycles:180 Average:20994.24 Median:21044.44 stddev:29923.46 (142.2%) stddev-sans-first:29968.96 17:20:31 INFO - PROCESS | 26708 | Values: 792.7 809.3 825.0 830.5 836.3 14560.1 14652.9 14800.3 14924.2 15204.9 15763.5 16340.4 16348.8 16975.6 17032.1 791.8 804.5 805.3 806.5 806.9 672.9 774.0 790.8 794.7 796.1 837.6 842.6 842.8 845.0 847.4 836.9 837.6 839.1 840.2 840.2 610.0 613.4 616.0 616.3 618.5 15579.7 15635.2 15674.9 15704.9 15722.9 14191.8 14598.9 14641.9 14674.5 14934.8 11948.3 12095.8 12130.7 12251.0 12323.6 3682.9 3721.5 3724.8 3808.4 3869.1 79490.6 80031.0 81451.0 81525.0 82780.6 11472.9 11674.6 11741.3 11754.6 11806.9 20404.0 21238.5 21307.0 21334.3 21431.2 8402.5 8802.4 8832.9 8859.4 8920.7 5030.2 5059.6 5066.8 5084.0 5141.5 3592.0 3606.7 3655.3 3669.2 3719.5 600.6 614.5 615.1 622.7 623.8 738.8 738.8 744.2 749.2 799.7 9011.5 9340.7 9388.8 9421.3 9557.6 693.9 741.0 754.4 762.0 778.9 4318.9 4371.6 4440.0 4453.4 4474.7 106834.0 107143.0 112522.0 112803.4 115911.4 95075.5 100602.5 101251.5 101689.0 103232.5 76895.6 78945.6 88338.6 89372.0 90258.0 8864.9 9655.7 10408.9 10429.5 10517.6 38280.4 51043.7 52191.5 53244.0 54397.5 70908.6 77627.6 78033.2 78146.0 79108.6 12691.7 12845.6 12924.7 12989.6 13203.0 14640.6 15011.2 15158.3 15505.4 15549.5 14209.9 14292.9 14341.8 14476.6 14645.5 13996.5 14285.5 14323.9 14385.1 14566.3 13680.1 13714.6 14112.4 14125.3 14547.7 10191.2 10687.7 11681.7 11817.0 12199.8 11080.7 11311.0 11523.7 11631.6 11700.2 17:20:31 INFO - PROCESS | 26708 | -------- Summary: end -------- 17:20:31 INFO - PROCESS | 26708 | 17:20:32 INFO - TEST-INFO | 26708: exit 0 17:20:32 INFO - TEST-OK | dromaeo_css | took 1111269ms 17:20:32 INFO - TEST-START | kraken 17:20:32 INFO - operating with platform_type : linux_ 17:20:32 INFO - Initialising browser for kraken test... 17:20:32 INFO - TEST-INFO | started process 26947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkKSrZA/profile http://localhost:56605/getInfo.html) 17:20:36 INFO - PROCESS | 26947 | __metrics Screen width/height:1600/1200 17:20:36 INFO - PROCESS | 26947 | colorDepth:24 17:20:36 INFO - PROCESS | 26947 | Browser inner width/height: 1024/697 17:20:36 INFO - PROCESS | 26947 | __metrics 17:20:37 ERROR - PROCESS | 26947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 17:20:38 INFO - TEST-INFO | 26947: exit 0 17:20:38 INFO - Browser initialized. 17:20:38 INFO - Running cycle 1/1 for kraken test... 17:20:38 INFO - TEST-INFO | started process 27069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkKSrZA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:20:50 INFO - PROCESS | 27069 | RSS: Main: 167235584 17:20:50 INFO - PROCESS | 27069 | 17:20:52 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56605/tests/kraken/driver.html?testName=audio-beat-detection) 17:20:53 INFO - PROCESS | 27069 | RSS: Main: 172625920 17:20:53 INFO - PROCESS | 27069 | 17:20:56 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56605/tests/kraken/driver.html?testName=audio-dft) 17:20:57 INFO - PROCESS | 27069 | RSS: Main: 172007424 17:20:57 INFO - PROCESS | 27069 | 17:20:59 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56605/tests/kraken/driver.html?testName=audio-fft) 17:21:00 INFO - PROCESS | 27069 | RSS: Main: 166805504 17:21:00 INFO - PROCESS | 27069 | 17:21:02 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56605/tests/kraken/driver.html?testName=audio-oscillator) 17:21:03 INFO - PROCESS | 27069 | RSS: Main: 167530496 17:21:03 INFO - PROCESS | 27069 | 17:21:05 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56605/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:21:06 INFO - PROCESS | 27069 | RSS: Main: 167870464 17:21:06 INFO - PROCESS | 27069 | 17:21:09 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56605/tests/kraken/driver.html?testName=imaging-darkroom) 17:21:09 INFO - PROCESS | 27069 | RSS: Main: 167219200 17:21:09 INFO - PROCESS | 27069 | 17:21:13 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56605/tests/kraken/driver.html?testName=imaging-desaturate) 17:21:13 INFO - PROCESS | 27069 | RSS: Main: 165851136 17:21:13 INFO - PROCESS | 27069 | 17:21:16 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56605/tests/kraken/driver.html?testName=json-parse-financial) 17:21:17 INFO - PROCESS | 27069 | RSS: Main: 167211008 17:21:17 INFO - PROCESS | 27069 | 17:21:18 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56605/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:21:19 INFO - PROCESS | 27069 | RSS: Main: 167682048 17:21:19 INFO - PROCESS | 27069 | 17:21:21 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:21:21 INFO - PROCESS | 27069 | RSS: Main: 167792640 17:21:21 INFO - PROCESS | 27069 | 17:21:24 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:21:24 INFO - PROCESS | 27069 | RSS: Main: 168615936 17:21:24 INFO - PROCESS | 27069 | 17:21:27 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:21:27 INFO - PROCESS | 27069 | RSS: Main: 168648704 17:21:27 INFO - PROCESS | 27069 | 17:21:30 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:21:31 INFO - PROCESS | 27069 | RSS: Main: 168669184 17:21:31 INFO - PROCESS | 27069 | 17:21:32 INFO - PROCESS | 27069 | Cycle 1(1): loaded http://localhost:56605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56605/tests/kraken/driver.html?testName=ai-astar) 17:21:33 INFO - PROCESS | 27069 | RSS: Main: 168853504 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | __start_tp_report 17:21:33 INFO - PROCESS | 27069 | _x_x_mozilla_page_load 17:21:33 INFO - PROCESS | 27069 | _x_x_mozilla_page_load_details 17:21:33 INFO - PROCESS | 27069 | |i|pagename|runs| 17:21:33 INFO - PROCESS | 27069 | |0;ai-astar;113;107;112;110;111;110;111;111;110;111 17:21:33 INFO - PROCESS | 27069 | |1;audio-beat-detection;156;126;156;179;134;160;165;127;195;126 17:21:33 INFO - PROCESS | 27069 | |2;audio-dft;162;161;161;161;162;164;172;169;163;163 17:21:33 INFO - PROCESS | 27069 | |3;audio-fft;75;76;74;164;74;74;74;76;164;77 17:21:33 INFO - PROCESS | 27069 | |4;audio-oscillator;85;85;154;87;85;86;141;85;86;152 17:21:33 INFO - PROCESS | 27069 | |5;imaging-gaussian-blur;117;118;116;117;117;117;118;118;117;117 17:21:33 INFO - PROCESS | 27069 | |6;imaging-darkroom;147;147;147;148;148;147;146;148;148;146 17:21:33 INFO - PROCESS | 27069 | |7;imaging-desaturate;95;95;94;96;95;95;95;96;95;96 17:21:33 INFO - PROCESS | 27069 | |8;json-parse-financial;56;56;55;54;56;56;58;53;55;55 17:21:33 INFO - PROCESS | 27069 | |9;json-stringify-tinderbox;64;63;68;64;64;62;62;64;63;63 17:21:33 INFO - PROCESS | 27069 | |10;stanford-crypto-aes;83;80;83;81;81;82;82;85;109;83 17:21:33 INFO - PROCESS | 27069 | |11;stanford-crypto-ccm;125;132;123;137;124;139;125;129;135;138 17:21:33 INFO - PROCESS | 27069 | |12;stanford-crypto-pbkdf2;159;160;165;159;162;160;159;155;159;160 17:21:33 INFO - PROCESS | 27069 | |13;stanford-crypto-sha256-iterative;63;68;66;64;65;69;64;63;63;63 17:21:33 INFO - PROCESS | 27069 | __end_tp_report 17:21:33 INFO - PROCESS | 27069 | __start_cc_report 17:21:33 INFO - PROCESS | 27069 | _x_x_mozilla_cycle_collect,879 17:21:33 INFO - PROCESS | 27069 | __end_cc_report 17:21:33 INFO - PROCESS | 27069 | __startTimestamp1465258893214__endTimestamp 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | ------- Summary: start ------- 17:21:33 INFO - PROCESS | 27069 | Number of tests: 14 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:1.58 (1.4%) stddev-sans-first:1.41 17:21:33 INFO - PROCESS | 27069 | Values: 113.0 107.0 112.0 110.0 111.0 110.0 111.0 111.0 110.0 111.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:158.00 stddev:23.90 (15.1%) stddev-sans-first:25.32 17:21:33 INFO - PROCESS | 27069 | Values: 156.0 126.0 156.0 179.0 134.0 160.0 165.0 127.0 195.0 126.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.74 (2.3%) stddev-sans-first:3.91 17:21:33 INFO - PROCESS | 27069 | Values: 162.0 161.0 161.0 161.0 162.0 164.0 172.0 169.0 163.0 163.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.50 stddev:37.54 (50.4%) stddev-sans-first:39.26 17:21:33 INFO - PROCESS | 27069 | Values: 75.0 76.0 74.0 164.0 74.0 74.0 74.0 76.0 164.0 77.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:85.00 stddev:30.82 (36.3%) stddev-sans-first:31.87 17:21:33 INFO - PROCESS | 27069 | Values: 85.0 85.0 154.0 87.0 85.0 86.0 141.0 85.0 86.0 152.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 17:21:33 INFO - PROCESS | 27069 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:21:33 INFO - PROCESS | 27069 | Values: 147.0 147.0 147.0 148.0 148.0 147.0 146.0 148.0 148.0 146.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:21:33 INFO - PROCESS | 27069 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.41 17:21:33 INFO - PROCESS | 27069 | Values: 56.0 56.0 55.0 54.0 56.0 56.0 58.0 53.0 55.0 55.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:1.70 (2.7%) stddev-sans-first:1.80 17:21:33 INFO - PROCESS | 27069 | Values: 64.0 63.0 68.0 64.0 64.0 62.0 62.0 64.0 63.0 63.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.50 stddev:8.58 (10.4%) stddev-sans-first:9.08 17:21:33 INFO - PROCESS | 27069 | Values: 83.0 80.0 83.0 81.0 81.0 82.0 82.0 85.0 109.0 83.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:133.50 stddev:6.27 (4.7%) stddev-sans-first:6.30 17:21:33 INFO - PROCESS | 27069 | Values: 125.0 132.0 123.0 137.0 124.0 139.0 125.0 129.0 135.0 138.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:2.53 (1.6%) stddev-sans-first:2.67 17:21:33 INFO - PROCESS | 27069 | Values: 159.0 160.0 165.0 159.0 162.0 160.0 159.0 155.0 159.0 160.0 17:21:33 INFO - PROCESS | 27069 | 17:21:33 INFO - PROCESS | 27069 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:2.20 (3.4%) stddev-sans-first:2.24 17:21:33 INFO - PROCESS | 27069 | Values: 63.0 68.0 66.0 64.0 65.0 69.0 64.0 63.0 63.0 63.0 17:21:33 INFO - PROCESS | 27069 | -------- Summary: end -------- 17:21:33 INFO - PROCESS | 27069 | 17:21:34 INFO - TEST-INFO | 27069: exit 0 17:21:34 INFO - TEST-OK | kraken | took 62050ms 17:21:34 INFO - SUITE-END | took 1173s 17:21:34 INFO - Completed test suite (00:19:33) 17:21:34 INFO - javascript benchmark 17:21:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7252.240268264516, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.5917230759997, 3145.308032232908, 3165.6834316568347, 3172.9682703172975, 3192.281736609263, 5363.38321093074, 5378.704171270583, 5392.865178370543, 5484.424135465769, 5511.724413779315, 5280.867978300545, 5334.946650533493, 5351.946480535194, 5355.277037599923, 5409.323834520685, 4793.520647935205, 4840.9515904840855, 4990.351254336932, 5052.115879721034, 5094.261332106842, 955.0448896802806, 4986.0, 4990.101781679296, 5017.021680772251, 5027.949720502785, 5022.1211288024815, 5040.445550989407, 5042.218456139304, 5051.217061355477, 5081.085404627165, 4867.294242334841, 5007.749612519396, 5043.394792624908, 5063.518965698253, 5072.315237442935, 4869.172240719086, 4948.554630083274, 4953.752312384367, 4957.603391728653, 5015.598752099823, 5295.708736019517, 5307.177387504943, 5328.760205790749, 5332.3601167859715, 5340.385855626575, 5756.8848623027725, 5793.826185214451, 5837.708114594253, 5874.0, 5918.319393269786, 5782.421757824226, 5883.588148829541, 5899.262592175978, 5909.704514774287, 5946.345901950782, 5454.4545545445535, 5494.725263736837, 5495.725213739297, 5501.614886957915, 5509.531689806371, 5866.2960444746905, 5873.853153671193, 5903.439173278532, 5926.970365148233, 5953.702314884238, 5775.5668324875805, 5804.071348584206, 5807.361190269067, 5809.244798176294, 5843.620164689281, 5857.7949771757785, 5875.823725288163, 5876.471117599436, 5881.941180588139, 5883.970580147157, 5738.483536481736, 5768.596198266081, 5780.826575202751, 5808.215890854765, 5838.649681019152, 5689.118186681071, 5746.511546518593, 5756.107803290497, 5781.392953739881, 5899.233099697012, 4368.7815609219415, 4382.627476664519, 4407.074514352022, 4417.3815665806815, 4437.290033594674, 3875.922481550353, 3899.8440062397754, 3902.941455878164, 3929.960700393017, 3948.7038472114705, 5546.057170281062, 5546.667199968015, 5549.972250138723, 5550.7779688812, 5568.164775283659, 5825.922204392201, 5843.152742852262, 5914.142449344821, 5919.319278283053, 5966.284045914518, 5424.9421362834655, 5453.0, 5472.808451704172, 5477.808276710376, 5528.612997090246, 4995.400551933792, 5017.724025178577, 5029.798808047711, 5042.42012168598, 5073.340465739504, 5860.120981852756, 5925.73334199962, 5958.523318134538, 6006.249218847644, 6008.849778755479, 5805.158252053428, 5822.970885145547, 5837.591368604157, 5938.287405511193, 5964.403559644001, 6053.788117415869, 6091.177691011834, 6094.8171554853425, 6112.022076467744, 6120.663363515049, 5689.601727879009, 5743.655380677173, 5799.304083509837, 5804.158397032491, 5827.300723912988, 5858.765649373977, 5973.880522389615, 5974.850628734316, 5983.9401605983385, 6028.33688294296, 5843.0, 5855.443732845373, 5856.619319744203, 5856.912146317723, 5863.648181109147, 5571.025070612708, 5664.093745000945, 5673.120666296731, 5775.27809023872, 5810.593258471867, 5436.7553460093595, 5548.0, 5592.049351610155, 5596.356419011866, 5664.405237450009, 5752.395998420273, 5759.337676167294, 5790.710464476843, 5793.884122317614, 5806.796762113306, 5522.66863988162, 5562.777488900399, 5631.774729010957, 5685.232493613309, 5686.545076393796], "value": 5353.237346550082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.4726798613262, 608.7047781825815, 610.6122612141289, 621.5804332075849, 622.5766478794424, 41878.0, 42926.0, 42970.0, 43093.56906430935, 46621.76689116558, 45540.08919821602, 45853.77073114638, 45916.0, 46165.307520387134, 46221.306680399735, 8805.427647202927, 8981.550922453884, 9004.68483603074, 9039.096090390942, 9065.1388118129, 8818.250448711868, 8941.061188575204, 8947.373683842134, 8990.68532601359, 9006.234470070052, 8988.775280618003, 8993.0, 9060.682876099338, 9064.0, 9096.317776166781, 8970.147835955606, 8984.326175536828, 9004.684836030707, 9020.233280171193, 9037.954810225972, 8733.083026282213, 8769.912300876973, 8773.859398278248, 8785.956070219672, 8821.823563528758, 42266.78866605678, 42655.57344426578, 42682.57317426817, 42796.35805462921, 42871.78564107191, 3369.0398236502724, 3442.431998720208, 3508.122969257686, 3549.716022718176, 3757.2861156380472, 30477.847610761804, 32142.357152857046, 32772.83613581941, 32841.0, 33674.0, 4359.6948213625055, 4456.502224261398, 4493.990246915442, 4541.45502539694, 4552.772361381951, 364068.0, 364308.0, 366196.0, 367256.0, 367436.16281918687, 58604.41395586075, 59013.70493147507, 59062.0, 59419.0, 59547.702261489285, 34824.30351392958, 63562.36437635565, 63721.362786371545, 63905.0, 64063.35936640667, 16667.49997500077, 17640.823591764176, 17738.645227095385, 17765.822341776675, 17806.46580602584, 13030.739385212242, 13050.0, 13136.146150500186, 13145.0, 13150.0, 19130.330438434587, 19225.807741922683, 19254.326098586484, 19278.518037048907, 19304.71042934357, 6856.6228857412325, 7011.544249623758, 7016.719331226694, 7289.870070139137, 7384.630768461556, 952.3143336797494, 1077.49357801833, 1106.4965440724452, 1111.3831823338126, 1153.5904753812445, 32408.0, 32613.83693081567, 32647.836760816517, 32767.67232327694, 32983.0, 1106.7952428800697, 1133.9603113890973, 1134.585876155214, 1158.5250047480492, 1211.9575814846437, 16402.671946561, 17026.829731702524, 17121.0, 17139.334768322165, 17209.397671081453, 585128.0, 587357.0, 590259.0, 591075.0, 593317.0, 56235.15647265294, 57131.14303285371, 57318.713406432704, 57391.0, 57421.13868291979, 1350.743358761832, 1368.568900796246, 1371.6228037289625, 1388.8541703121027, 1395.6301580081285, 30451.0, 31633.683663163072, 31683.683163168072, 31840.363192735553, 32425.0, 50530.2420463686, 50816.0, 51003.0, 51412.0, 51462.22806657828, 455212.0, 466145.0, 466675.0, 467040.0, 468247.0, 27694.0, 27860.16419507418, 28056.29859253535, 28104.71895281021, 28142.43715125645, 47276.0, 47952.28071578999, 48246.276305854735, 49014.75492622514, 49142.508574913794, 40373.59626403816, 40546.797266013484, 40643.59356406398, 40646.0, 41819.58180418279, 39420.60579394169, 40012.799936000134, 40393.0, 40613.59386406098, 40939.7953010233, 39832.40670373268, 40627.187456251304, 40703.79648101741, 41098.38352424776, 41418.58581414147, 33566.0, 35551.46672799962, 36117.09707257339, 36177.45733814048, 36213.818930905174, 27546.86226568854, 27606.5859012119, 27699.86150069237, 27847.16458506248, 28065.71934280631], "value": 20350.81890107551, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3497858576176, 396.7698734733854, 397.17784186733456, 399.16176030336317, 420.6928941872433, 17987.910060449696, 18655.3470628528, 19357.0, 19583.902080489595, 19584.216631334748, 17919.82080179198, 18134.909325453355, 18487.2605095796, 18957.905210473964, 19007.049647517604, 5400.1629747389115, 5573.832785016436, 5778.8266352009505, 5784.797532086378, 5787.971060144693, 5628.774849006056, 5634.830955071334, 5653.434656534334, 5676.602637815355, 5680.4319568043275, 5406.810761623344, 5592.888142237153, 5708.97145514274, 5726.770929162829, 5740.225069615591, 5690.573207009491, 5694.77220911163, 5698.686572238505, 5704.458076482748, 5719.28508936383, 4933.950660493421, 5105.846824595268, 5129.9483605860705, 5153.252778347119, 5155.587552995751, 21861.781382186135, 22160.88919555392, 22338.10647574095, 22481.0, 22506.0, 2132.818710409617, 2342.273895092527, 2406.831521793475, 2413.8310318277727, 2515.2705715342527, 9400.905990940071, 9612.423254604746, 10318.432486213254, 10380.32527885685, 10385.79228415435, 1834.3763120539081, 1899.591587808614, 1926.2391355414672, 1978.4163671716879, 2001.1195074167465, 65308.0, 82493.0, 82839.58580207061, 83072.0, 85178.0, 10658.200634952409, 10808.51361688726, 11121.499532521057, 11143.387113708663, 11424.865296348067, 15375.384984600714, 15410.768838467431, 15453.150076745887, 15478.303476343592, 15527.0, 8138.674453021813, 8266.628001739817, 8311.625976830936, 8472.788180295542, 8497.192766687154, 8050.879236811453, 8148.10370859205, 8185.836283274301, 8338.291245244221, 8356.415050946376, 4707.8587642370785, 4751.691140075884, 4801.975990120027, 4808.326834243208, 4867.440244371872, 1901.6386886491523, 1968.6161198566142, 1972.5068732816796, 2028.949276268105, 2082.9687554686693, 927.638221093774, 946.8721722567366, 998.236349192868, 1005.261133067195, 1038.7506998320348, 18297.26810927548, 18613.0, 18618.627627447648, 18886.43340699781, 18994.525136871413, 1000.9049140331657, 1005.7586179316911, 1008.4755926917961, 1020.6019652335596, 1087.896649818266, 5978.970105149447, 6184.103305020837, 10149.0, 10592.311499752492, 10687.83968240477, 301204.0, 301452.0, 383323.0, 457395.0, 515609.0, 64465.0, 79096.6045169782, 80912.59543702361, 91412.0, 96186.0, 482.4524165072598, 493.1370102320938, 495.14587336844374, 497.1449107535034, 498.27003439960635, 9977.201823854219, 10550.0, 10789.784204316027, 11534.769304613694, 11594.76810463803, 40703.79648101741, 42269.0, 44968.77515612401, 45606.54393456023, 46679.29981050219, 61621.69189154205, 62499.37500624936, 62616.37383626105, 63016.05475917957, 63098.36901631109, 8285.337173026264, 8680.218780309802, 8694.17405346491, 8723.781905452415, 8879.200871921557, 11435.485403157045, 13026.80459793085, 13066.477340906258, 13172.275524845842, 13294.135881167693, 11160.218784684994, 11190.776184476103, 11217.71955701114, 11292.040176585082, 11551.653450396501, 11338.546458141582, 11461.426928653367, 11503.0, 11650.41747912618, 11688.532458701897, 10917.290376125526, 11126.0, 11397.829032564685, 11530.192886497865, 11564.595239166589, 8904.332175086765, 11039.944800275947, 11583.884161158281, 12071.517139314328, 12594.811077833656, 11002.449877505933, 11411.372374519482, 11426.085913127095, 11829.112816538965, 12054.578089766816], "value": 8825.611445990542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.014490219102, 1488.8138982627172, 1620.424749214029, 1742.4249997500826, 1767.3549154558582, 7786.805329866742, 8331.95834020829, 8403.369747268956, 8906.554672266386, 8911.509866957314, 8502.91497085029, 8710.172533609313, 8726.083761205076, 8740.912590874104, 8782.38523303369, 2372.2290255666935, 2380.7262164851004, 2395.760423957599, 2403.0748161957686, 2403.146882856587, 2315.5947709150832, 2339.0526836631107, 2383.95232095358, 2387.868667223302, 2390.964135537968, 2361.1853910400882, 2361.4686695493547, 2368.3605426534828, 2373.4303767095944, 2388.5103553771437, 2258.0, 2269.1944359752297, 2273.7271527416733, 2273.9317820465412, 2293.2546922250335, 2278.157081879715, 2284.0521183708743, 2285.360099172218, 2287.0, 2297.7587353327995, 8697.565121743888, 8751.737447876574, 8763.737087887373, 8764.0, 8767.0, 5130.871728206787, 5247.527722504993, 5339.652922560022, 5367.946320536784, 5373.408925018245, 3338.2822693121097, 3456.9827150864085, 3479.0780443182575, 3563.5901871284873, 3568.928621427583, 1150.71232191952, 1195.3664557784389, 1226.129448091856, 1238.1704258147063, 1241.453760345445, 11759.0, 11847.703807404798, 11870.109741769402, 11887.346195959219, 11926.701832454171, 4635.605973492224, 4689.95310046902, 4761.642876784255, 4786.2581299898575, 4791.353167322367, 10160.949195253976, 10162.39025658463, 10181.847272290921, 10213.642522511676, 10223.131033862204, 5278.5249327560705, 5326.36083669962, 5339.119045357473, 5341.519263266325, 5351.063563876306, 4370.584794444522, 4748.121597504472, 4850.733209673432, 4883.633727470454, 4917.852464426073, 3989.162275922089, 4022.35642297231, 4111.568285330057, 4147.170565886835, 4172.666186705056, 1291.9031072669588, 1301.7136230029378, 1317.2030921292671, 1333.2267284974885, 1344.1196016609138, 901.6123067081218, 1012.6455740490769, 1015.4821041269006, 1016.5832008876325, 1028.93311934724, 5954.970225148846, 5999.880002399927, 6008.158857759917, 6014.488768454643, 6168.845778855475, 463.2610985478157, 471.4935780182353, 475.4769753271374, 482.6356101143614, 485.6042325504702, 4076.164386300801, 4203.726757760735, 4211.136716973013, 4216.599423054805, 4248.723832950848, 10245.7438564035, 10776.29954052984, 10806.189535784848, 10841.07850832688, 10894.40080795548, 10218.437985910847, 10589.0, 10607.734806629896, 10782.353058816496, 10946.288491248044, 8078.313343365762, 8228.547429891294, 8230.382721295926, 8260.876086858581, 8291.253787159185, 6056.757729690763, 6228.968855155696, 6272.905906411499, 6291.528135389773, 6316.778912738216, 9907.356021858555, 9945.701628951143, 9952.651657191964, 9966.0, 9966.950165249127, 9570.47362395075, 9889.50552472388, 9923.305368624127, 10071.244656650633, 10201.744956375853, 7041.683124259318, 7651.1583725789005, 7783.0, 7832.960835195788, 8014.759557213293, 8088.474249173785, 8352.248297653241, 8363.916360836314, 8378.329733621174, 8453.196946290092, 7391.482596218213, 7641.1212710539, 7642.541447513167, 7698.92301076982, 7714.305712485903, 7023.47323950716, 7059.011738356531, 7100.502964792415, 7133.215346312006, 7317.5609463432365, 6686.7993960181275, 6791.0, 6851.657417129024, 6859.005444210661, 6863.347981941708, 4954.801807927643, 5070.41690205631, 5155.046316431472, 5201.81793637236, 5303.7878484860175, 4923.876903077452, 5022.447530771539, 5102.4642412546145, 5119.436861945109, 5149.201873709581], "value": 4561.710604101996, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.9422906762249, 320.4040484698462, 321.3492677328411, 327.8459124211621, 328.6795374509853, 5375.865603359918, 5431.0, 5503.807366742165, 5610.625396777785, 5645.9554982328245, 5479.808206712766, 5511.862203444916, 5516.565692919839, 5537.778488860441, 5565.972170139144, 4302.290122129861, 4312.417823593806, 4312.439382880221, 4328.307470804664, 4350.782460876943, 4150.97924510377, 4333.306670932651, 4340.804663790122, 4350.630196433307, 4351.608355248027, 4241.300185469409, 4282.700210985232, 4285.657147428198, 4286.142771445708, 4296.806643701041, 4228.809703563347, 4268.551802060801, 4299.097189590189, 4305.117450922553, 4325.091730736549, 3655.232401195752, 3829.2341531693496, 3836.5037635322246, 3852.6917846572205, 3861.2470568238923, 5269.55208807248, 5323.760430780624, 5327.334083239595, 5330.866728331784, 5354.527504936134, 4945.120854075464, 4977.601791856643, 4990.975045124787, 5001.249812528114, 5006.6245031622775, 5620.887582248332, 5834.241548598655, 5837.678927658977, 5898.262717160355, 5902.734376953004, 4142.514491305223, 4183.226103170923, 4194.406125672255, 4205.11692544566, 4211.789410529461, 6041.395860413967, 6042.428968468186, 6061.696915154269, 6083.479130217445, 6109.847253818646, 4076.9592304076577, 4294.806733696991, 4333.0, 4334.848280310174, 4343.04453020335, 4405.427294451701, 4407.272799987966, 4411.514733379326, 4431.379606855043, 4434.26834572292, 4998.0, 5014.498550145029, 5025.120603894377, 5032.597392208614, 5033.0940430722085, 5739.454751798572, 5889.38161493037, 5918.704064796743, 5920.259967504062, 5968.850778730566, 1494.4321157960123, 1501.8648321651103, 1507.4648499782638, 1509.7207016701946, 1517.3020410611023, 936.2977766674994, 974.4396971741277, 977.4526265291317, 981.6613268422383, 984.5028260728429, 4983.6013118950395, 5006.4743201964, 5068.974655126701, 5078.060558796635, 5134.460881607452, 5324.760385782649, 5327.334083239595, 5332.626716129834, 5336.279602253724, 5394.649347792381, 4838.685485443435, 4968.30443737877, 4976.8755781105765, 5078.187490001582, 5110.6678065926335, 2858.2568532181367, 2861.4563232985665, 2876.3240638449947, 2886.6536015678253, 2914.1932002158796, 5509.283793106951, 5514.696691681996, 5518.475744804237, 5526.4197259288, 5592.266397416814, 5327.653702509402, 5404.189371594213, 5444.4211178758505, 5473.972630136904, 5528.612997090165, 5351.598630102758, 5505.862353441196, 5532.3914369419335, 5534.8653526027065, 5555.722213889289, 5278.419373868948, 5305.779670675844, 5358.544523715528, 5387.703676297841, 5537.4495141360485, 5967.701614919323, 5985.700714964148, 5994.400559943971, 6029.939700602938, 6030.155778190969, 5898.380670029585, 6277.435030847246, 6279.560430769802, 6284.277308109626, 6287.591306565241, 4051.513818341818, 4116.991337122424, 4160.3343465046655, 4162.105147393325, 4185.518665353523, 5929.407059294036, 5936.13925980739, 5949.315828679584, 6008.008678567988, 6039.818805435844, 5704.258446401941, 5757.251557297692, 5776.7111644418455, 5794.449527294901, 5817.331006934257, 5731.398203188772, 5739.397363276963, 5748.195252664714, 5756.301890942098, 5786.392428794916, 5639.561911712487, 5654.123610840326, 5656.547476201977, 5658.490735833795, 5681.517071049007, 5581.49766521015, 5837.211976383134, 5847.883042339215, 5847.94152058491, 5860.501857342174, 5610.579206559442, 5663.235463212413, 5693.117566777156, 5693.28833895763, 5714.428557144252], "value": 4327.319756301984, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.6564473217896, 809.2716555100412, 825.0264687668556, 830.5224495914848, 836.289154218914, 14560.126392416463, 14652.926735366322, 14800.333984970675, 14924.179170145637, 15204.923975380121, 15763.527094187193, 16340.428085017027, 16348.75476867848, 16975.57561060974, 17032.063236521986, 791.8218400859818, 804.4811096842533, 805.3235282362814, 806.4999700185864, 806.8587997100514, 672.9360710732496, 773.9729109481169, 790.7746292306693, 794.6900708723573, 796.1043825696092, 837.6481877611387, 842.5618678287318, 842.7935155886817, 844.9704260350858, 847.3602430165216, 836.9455985360933, 837.6481877611418, 839.1105428246049, 840.1892174052039, 840.2018082821344, 610.0270069239556, 613.3927411862269, 616.0205273614973, 616.2881871438495, 618.5330075792748, 15579.688406231811, 15635.218239088, 15674.9216253918, 15704.921475392664, 15722.921385393114, 14191.78712319316, 14598.92700536501, 14641.853581464156, 14674.486392976301, 14934.775978360334, 11948.342841143734, 12095.758084838342, 12130.696732581668, 12251.0, 12323.568675096329, 3682.9263414731554, 3721.4789929409903, 3724.7578907371203, 3808.447775072599, 3869.1294458746556, 79490.60254698689, 80031.0, 81451.0, 81525.0, 82780.58609706972, 11472.885271147348, 11674.591389301333, 11741.29552226869, 11754.588589399329, 11806.940965295118, 20404.0, 21238.46903827417, 21307.0, 21334.253301134697, 21431.249906253517, 8402.537860417735, 8802.383833131747, 8832.91167088321, 8859.424137431046, 8920.687775927941, 5030.170021946411, 5059.64357931029, 5066.771995260222, 5084.0, 5141.460146684619, 3591.982040089783, 3606.693431058337, 3655.287218992271, 3669.174435751988, 3719.497867787868, 600.5975996082635, 614.4961131871911, 615.0958091605333, 622.7011034703277, 623.8440389902524, 738.811603041221, 738.8226825561934, 744.162816831065, 749.1609397474754, 799.7320897499286, 9011.549422528979, 9340.71977840666, 9388.812223755624, 9421.293402994803, 9557.617695292249, 693.9236683964759, 740.9848507544698, 754.3663322808867, 761.9580923049285, 778.8753799392183, 4318.935215971763, 4371.562843715603, 4439.955600444019, 4453.376527286183, 4474.6867719259335, 106834.0, 107143.0, 112522.0, 112803.4359828212, 115911.42044289724, 95075.52462237644, 100602.49698751606, 101251.49374253082, 101689.0, 103232.48383758034, 76895.61552192204, 78945.60527197442, 88338.55830720934, 89372.0, 90258.0, 8864.911350886667, 9655.710328690151, 10408.947955260175, 10429.478526073817, 10517.579296828042, 38280.42579361256, 51043.744781275855, 52191.47808522018, 53244.0, 54397.45602543924, 70908.64545677445, 77627.61186194033, 78033.2196678026, 78146.0, 79108.60445697735, 12691.682707932006, 12845.550405735754, 12924.676883077998, 12989.610311690665, 13203.0, 14640.633984150481, 15011.249437527862, 15158.31787569584, 15505.379784808933, 15549.455769048029, 14209.928950355183, 14292.928535357256, 14341.78487322712, 14476.638084047983, 14645.48740794067, 13996.46528763124, 14285.500007499688, 14323.928380358031, 14385.136891786526, 14566.271686415424, 13680.110792798436, 13714.593580700483, 14112.435502580192, 14125.293735313398, 14547.709045819236, 10191.184705223712, 10687.659870365434, 11681.707957301136, 11816.986980781154, 12199.817002744789, 11080.722981925517, 11311.0, 11523.711907202387, 11631.59289424866, 11700.239484433485], "value": 7664.76083471417, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 156.0, 179.0, 134.0, 160.0, 165.0, 127.0, 195.0, 126.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 164.0, 172.0, 169.0, 163.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 164.0, 74.0, 74.0, 74.0, 76.0, 164.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 154.0, 87.0, 85.0, 86.0, 141.0, 85.0, 86.0, 152.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 146.0, 148.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 54.0, 56.0, 56.0, 58.0, 53.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 68.0, 64.0, 64.0, 62.0, 62.0, 64.0, 63.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 83.0, 81.0, 81.0, 82.0, 82.0, 85.0, 109.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 123.0, 137.0, 124.0, 139.0, 125.0, 129.0, 135.0, 138.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 165.0, 159.0, 162.0, 160.0, 159.0, 155.0, 159.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 66.0, 64.0, 65.0, 69.0, 64.0, 63.0, 63.0, 63.0], "value": 64.8, "unit": "score"}]}]} 17:21:34 INFO - Return code: 0 17:21:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:21:34 ERROR - # TBPL SUCCESS # 17:21:34 INFO - Running post-action listener: _resource_record_post_action 17:21:34 INFO - ##### 17:21:34 INFO - ##### Finished run-tests step (success) 17:21:34 INFO - ##### 17:21:34 INFO - Running post-run listener: _resource_record_post_run 17:21:34 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 0; Write bytes: 541048832; Read time: 0; Write time: 711744 17:21:34 INFO - TinderboxPrint: CPU usage
13.5% 17:21:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:21:34 INFO - TinderboxPrint: I/O write bytes / time
541,048,832 / 711,744 17:21:34 INFO - TinderboxPrint: CPU idle
8,214.3 (86.4%) 17:21:34 INFO - TinderboxPrint: CPU user
1,228.3 (12.9%) 17:21:34 INFO - TinderboxPrint: Swap in / out
0 / 0 17:21:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248164352; Read time: 0; Write time: 339320 17:21:34 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 0; Write bytes: 292216832; Read time: 0; Write time: 372392 17:21:35 INFO - Running post-run listener: _upload_blobber_files 17:21:35 INFO - Blob upload gear active. 17:21:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:21:35 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 17:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:21:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:21:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:21:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:21:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:36 INFO - (blobuploader) - INFO - Done attempting. 17:21:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:21:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:37 INFO - (blobuploader) - INFO - Done attempting. 17:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:21:41 INFO - (blobuploader) - INFO - Done attempting. 17:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:21:41 INFO - Return code: 0 17:21:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc5d747d10c15f0c9345f096bd54d4c8b747b31123d1e1954d908ec73c041e40d5ec9538913e931f2a2bd1db95c61563ea1ba06ec81b7a1c6d86e37d6cf2a613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6bc12cf79c28e0b94a24193bced28fb5e76dffcf01b06c680d0fc3539c370df42b7c0d31391904c2671b4bb73d2e6a8bdba9c8a2d1c4c107f6e5cbacf739d10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e4bca43813ac44fa62e5c5cf8f54c70d8d13b2f50ee27cc8a601d922df389b27757b8d4978ac8b29c3c8b04dee8c5fd52007a3311918fe0426853a0ad4f2bd"} 17:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:21:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:21:41 INFO - Contents: 17:21:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc5d747d10c15f0c9345f096bd54d4c8b747b31123d1e1954d908ec73c041e40d5ec9538913e931f2a2bd1db95c61563ea1ba06ec81b7a1c6d86e37d6cf2a613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6bc12cf79c28e0b94a24193bced28fb5e76dffcf01b06c680d0fc3539c370df42b7c0d31391904c2671b4bb73d2e6a8bdba9c8a2d1c4c107f6e5cbacf739d10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e4bca43813ac44fa62e5c5cf8f54c70d8d13b2f50ee27cc8a601d922df389b27757b8d4978ac8b29c3c8b04dee8c5fd52007a3311918fe0426853a0ad4f2bd"} 17:21:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:21:41 INFO - Copying logs to upload dir... 17:21:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:21:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.068805 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-06 17:21:41.102663) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 17:21:41.105867) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc5d747d10c15f0c9345f096bd54d4c8b747b31123d1e1954d908ec73c041e40d5ec9538913e931f2a2bd1db95c61563ea1ba06ec81b7a1c6d86e37d6cf2a613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6bc12cf79c28e0b94a24193bced28fb5e76dffcf01b06c680d0fc3539c370df42b7c0d31391904c2671b4bb73d2e6a8bdba9c8a2d1c4c107f6e5cbacf739d10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e4bca43813ac44fa62e5c5cf8f54c70d8d13b2f50ee27cc8a601d922df389b27757b8d4978ac8b29c3c8b04dee8c5fd52007a3311918fe0426853a0ad4f2bd"} build_url:https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc5d747d10c15f0c9345f096bd54d4c8b747b31123d1e1954d908ec73c041e40d5ec9538913e931f2a2bd1db95c61563ea1ba06ec81b7a1c6d86e37d6cf2a613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6bc12cf79c28e0b94a24193bced28fb5e76dffcf01b06c680d0fc3539c370df42b7c0d31391904c2671b4bb73d2e6a8bdba9c8a2d1c4c107f6e5cbacf739d10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77e4bca43813ac44fa62e5c5cf8f54c70d8d13b2f50ee27cc8a601d922df389b27757b8d4978ac8b29c3c8b04dee8c5fd52007a3311918fe0426853a0ad4f2bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 17:21:41.130948) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:21:41.131251) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465257666.48683-1802158645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:21:41.215944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 17:21:41.216432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 17:21:41.216920) ========= ========= Total master_lag: 0.17 =========