builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1465257717.79 results: success (0) buildid: 20160606143009 builduid: 8127c73dd1ad473c89c4a483a6065172 revision: 883b0a89b3212b6b55b7e6fde69d0438c39899ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:57.786053) ========= 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:57.786520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:57.786797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:57.801360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:57.801701) ========= 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=df17445c3590ff7897617a0e00000225-1465257716.755680-558871115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 17:01:57-- 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% 42.5M=0s 2016-06-06 17:01:57 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084505 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:57.898953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:57.899293) ========= 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=df17445c3590ff7897617a0e00000225-1465257716.755680-558871115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019214 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:57.948347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 17:01:57.950060) ========= 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=df17445c3590ff7897617a0e00000225-1465257716.755680-558871115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 17:01:57,998 truncating revision to first 12 chars 2016-06-06 17:01:57,998 Setting DEBUG logging. 2016-06-06 17:01:57,998 attempt 1/10 2016-06-06 17:01:57,998 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:59,150 unpacking tar archive at: fx-team-883b0a89b321/testing/mozharness/ program finished with exit code 0 elapsedTime=1.483600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-06 17:01:59.446967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:59.447296) ========= script_repo_revision: 883b0a89b3212b6b55b7e6fde69d0438c39899ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:59.447780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:59.448056) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 17:01:59.458773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-06 17:01:59.459111) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=df17445c3590ff7897617a0e00000225-1465257716.755680-558871115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:01:59 INFO - MultiFileLogger online at 20160606 17:01:59 in /builds/slave/test 17:01:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:01:59 INFO - {'append_to_log': False, 17:01:59 INFO - 'base_work_dir': '/builds/slave/test', 17:01:59 INFO - 'blob_upload_branch': 'Fx-Team', 17:01:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:01:59 INFO - 'branch': 'Fx-Team', 17:01:59 INFO - 'buildbot_json_path': 'buildprops.json', 17:01:59 INFO - 'config_files': ('talos/linux_config.py',), 17:01:59 INFO - 'default_actions': ('clobber', 17:01:59 INFO - 'read-buildbot-config', 17:01:59 INFO - 'download-and-extract', 17:01:59 INFO - 'populate-webroot', 17:01:59 INFO - 'create-virtualenv', 17:01:59 INFO - 'install', 17:01:59 INFO - 'run-tests'), 17:01:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:01:59 INFO - 'download_minidump_stackwalk': True, 17:01:59 INFO - 'download_symbols': 'ondemand', 17:01:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:01:59 INFO - 'tooltool.py': '/tools/tooltool.py', 17:01:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:01:59 INFO - '/tools/misc-python/virtualenv.py')}, 17:01:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:01:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:01:59 INFO - 'installer_path': 'installer.exe', 17:01:59 INFO - 'log_level': 'info', 17:01:59 INFO - 'log_name': 'talos', 17:01:59 INFO - 'log_to_console': True, 17:01:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:01:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:01:59 INFO - 'opt_config_files': (), 17:01:59 INFO - 'pip_index': False, 17:01:59 INFO - 'sps_profile': False, 17:01:59 INFO - 'sps_profile_interval': 0, 17:01:59 INFO - 'suite': 'dromaeojs', 17:01:59 INFO - 'system_bits': '32', 17:01:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:01:59 INFO - 'title': 'talos-linux64-ix-021', 17:01:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:01:59 INFO - 'use_talos_json': True, 17:01:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:01:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:01:59 INFO - 'work_dir': 'build'} 17:01:59 INFO - ##### 17:01:59 INFO - ##### Running clobber 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: clobber 17:01:59 INFO - rmtree: /builds/slave/test/build 17:01:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:02:00 INFO - Running post-action listener: _resource_record_post_action 17:02:00 INFO - ##### 17:02:00 INFO - ##### Finished clobber step (success) 17:02:00 INFO - ##### 17:02:00 INFO - ##### 17:02:00 INFO - ##### Running read-buildbot-config step. 17:02:00 INFO - ##### 17:02:00 INFO - Running pre-action listener: _resource_record_pre_action 17:02:00 INFO - Running main action method: read_buildbot_config 17:02:00 INFO - Using buildbot properties: 17:02:00 INFO - { 17:02:00 INFO - "project": "", 17:02:00 INFO - "product": "firefox", 17:02:00 INFO - "script_repo_revision": "production", 17:02:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:02:00 INFO - "repository": "", 17:02:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:02:00 INFO - "buildid": "20160606143009", 17:02:00 INFO - "pgo_build": "True", 17:02:00 INFO - "basedir": "/builds/slave/test", 17:02:00 INFO - "buildnumber": 163, 17:02:00 INFO - "slavename": "talos-linux64-ix-021", 17:02:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:02:00 INFO - "platform": "ubuntu64_hw", 17:02:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:02:00 INFO - "branch": "fx-team", 17:02:00 INFO - "repo_path": "integration/fx-team", 17:02:00 INFO - "revision": "883b0a89b3212b6b55b7e6fde69d0438c39899ff", 17:02:00 INFO - "stage_platform": "linux64-pgo", 17:02:00 INFO - "builduid": "8127c73dd1ad473c89c4a483a6065172", 17:02:00 INFO - "slavebuilddir": "test" 17:02:00 INFO - } 17:02:00 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:02:00 INFO - Running post-action listener: _resource_record_post_action 17:02:00 INFO - ##### 17:02:00 INFO - ##### Finished read-buildbot-config step (success) 17:02:00 INFO - ##### 17:02:00 INFO - ##### 17:02:00 INFO - ##### Running download-and-extract step. 17:02:00 INFO - ##### 17:02:00 INFO - Running pre-action listener: _resource_record_pre_action 17:02:00 INFO - Running main action method: download_and_extract 17:02:00 INFO - mkdir: /builds/slave/test/build/tests 17:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:00 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:02:00 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:02:00 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:02:00 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:02:00 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:02:00 INFO - Downloaded 1361 bytes. 17:02:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:02:00 INFO - Using the following test package requirements: 17:02:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:02:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:02:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'jsshell-linux-x86_64.zip'], 17:02:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:02:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:02:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:02:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:02:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:02:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:00 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:02:00 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:02:00 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:02:00 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:02:00 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:02:01 INFO - Downloaded 24443829 bytes. 17:02:01 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:02:01 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:02:03 INFO - Return code: 0 17:02:03 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:02:03 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:02:03 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:02:03 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:02:03 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:02:03 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:02:03 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:02:04 INFO - Downloaded 24443829 bytes. 17:02:04 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:02:04 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:02:05 INFO - Return code: 0 17:02:05 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:02:05 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:02:05 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:02:05 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:02:05 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:02:05 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:02:06 INFO - Downloaded 10833369 bytes. 17:02:06 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:02:06 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:02:07 INFO - Return code: 0 17:02:07 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:02:07 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:02:07 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:02:07 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:02:07 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:02:07 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:02:08 INFO - Downloaded 59193531 bytes. 17:02:08 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:02:08 INFO - mkdir: /builds/slave/test/properties 17:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:08 INFO - Contents: 17:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/BuYhmW1uR86CzUKJnQOqXA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:02:09 INFO - Running post-action listener: _resource_record_post_action 17:02:09 INFO - Running post-action listener: set_extra_try_arguments 17:02:09 INFO - ##### 17:02:09 INFO - ##### Finished download-and-extract step (success) 17:02:09 INFO - ##### 17:02:09 INFO - ##### 17:02:09 INFO - ##### Running populate-webroot step. 17:02:09 INFO - ##### 17:02:09 INFO - Running pre-action listener: _resource_record_pre_action 17:02:09 INFO - Running main action method: populate_webroot 17:02:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:09 INFO - '--tppagecycles', 17:02:09 INFO - '7'], 17:02:09 INFO - 'tests': ['tsvgm']}}, 17:02:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['damp', 'tps']}, 17:02:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'tests': ['damp', 'tps']}, 17:02:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['dromaeo_dom']}, 17:02:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['a11yr', 17:02:09 INFO - 'ts_paint', 17:02:09 INFO - 'tpaint', 17:02:09 INFO - 'sessionrestore', 17:02:09 INFO - 'sessionrestore_no_auto_restore', 17:02:09 INFO - 'tabpaint']}, 17:02:09 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:09 INFO - 'ts_paint', 17:02:09 INFO - 'tpaint', 17:02:09 INFO - 'sessionrestore', 17:02:09 INFO - 'sessionrestore_no_auto_restore', 17:02:09 INFO - 'tabpaint']}, 17:02:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:09 INFO - 'ts_paint', 17:02:09 INFO - 'tpaint', 17:02:09 INFO - 'sessionrestore', 17:02:09 INFO - 'sessionrestore_no_auto_restore', 17:02:09 INFO - 'tabpaint']}, 17:02:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:09 INFO - 'ts_paint', 17:02:09 INFO - 'tpaint', 17:02:09 INFO - 'sessionrestore', 17:02:09 INFO - 'sessionrestore_no_auto_restore', 17:02:09 INFO - 'tabpaint']}, 17:02:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['a11yr', 17:02:09 INFO - 'ts_paint', 17:02:09 INFO - 'tpaint', 17:02:09 INFO - 'sessionrestore', 17:02:09 INFO - 'sessionrestore_no_auto_restore', 17:02:09 INFO - 'tabpaint']}, 17:02:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['a11yr', 17:02:09 INFO - 'ts_paint', 17:02:09 INFO - 'tpaint', 17:02:09 INFO - 'sessionrestore', 17:02:09 INFO - 'sessionrestore_no_auto_restore', 17:02:09 INFO - 'tabpaint']}, 17:02:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['tsvgx', 17:02:09 INFO - 'tsvgr_opacity', 17:02:09 INFO - 'tart', 17:02:09 INFO - 'tscrollx', 17:02:09 INFO - 'cart']}, 17:02:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:09 INFO - 'tsvgr_opacity', 17:02:09 INFO - 'tart', 17:02:09 INFO - 'tscrollx', 17:02:09 INFO - 'cart']}, 17:02:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'talos_options': ['--disable-e10s'], 17:02:09 INFO - 'tests': ['tp5o']}, 17:02:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'tests': ['tp5o']}, 17:02:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'talos_options': ['--disable-e10s', 17:02:09 INFO - '--xperf_path', 17:02:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:09 INFO - 'tests': ['tp5n']}, 17:02:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:09 INFO - 'talos_options': ['--xperf_path', 17:02:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:09 INFO - 'tests': ['tp5n']}}, 17:02:09 INFO - 'talos.zip': {'path': '', 17:02:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:09 INFO - Running post-action listener: _resource_record_post_action 17:02:09 INFO - ##### 17:02:09 INFO - ##### Finished populate-webroot step (success) 17:02:09 INFO - ##### 17:02:09 INFO - ##### 17:02:09 INFO - ##### Running create-virtualenv step. 17:02:09 INFO - ##### 17:02:09 INFO - Running pre-action listener: _resource_record_pre_action 17:02:09 INFO - Running main action method: create_virtualenv 17:02:09 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:09 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:02:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:09 INFO - Using real prefix '/usr' 17:02:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:09 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:11 INFO - Installing pip.................done. 17:02:11 INFO - Return code: 0 17:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02: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:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:02:11 INFO - Using env: {'DISPLAY': ':0', 17:02:11 INFO - 'HOME': '/home/cltbld', 17:02:11 INFO - 'LANG': 'en_US.UTF-8', 17:02:11 INFO - 'LANGUAGE': 'en_US:en', 17:02:11 INFO - 'LOGNAME': 'cltbld', 17:02:11 INFO - 'MAIL': '/var/mail/cltbld', 17:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:11 INFO - 'MOZ_NO_REMOTE': '1', 17:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:11 INFO - 'NO_EM_RESTART': '1', 17:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:11 INFO - 'PWD': '/builds/slave/test', 17:02:11 INFO - 'SHELL': '/bin/bash', 17:02:11 INFO - 'SHLVL': '1', 17:02:11 INFO - 'TERM': 'linux', 17:02:11 INFO - 'TMOUT': '86400', 17:02:11 INFO - 'USER': 'cltbld', 17:02:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:11 INFO - '_': '/tools/buildbot/bin/python'} 17:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:11 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:02:11 INFO - Cleaning up... 17:02:11 INFO - Return code: 0 17:02:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:02: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:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:02:11 INFO - Using env: {'DISPLAY': ':0', 17:02:11 INFO - 'HOME': '/home/cltbld', 17:02:11 INFO - 'LANG': 'en_US.UTF-8', 17:02:11 INFO - 'LANGUAGE': 'en_US:en', 17:02:11 INFO - 'LOGNAME': 'cltbld', 17:02:11 INFO - 'MAIL': '/var/mail/cltbld', 17:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:11 INFO - 'MOZ_NO_REMOTE': '1', 17:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:11 INFO - 'NO_EM_RESTART': '1', 17:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:11 INFO - 'PWD': '/builds/slave/test', 17:02:11 INFO - 'SHELL': '/bin/bash', 17:02:11 INFO - 'SHLVL': '1', 17:02:11 INFO - 'TERM': 'linux', 17:02:11 INFO - 'TMOUT': '86400', 17:02:11 INFO - 'USER': 'cltbld', 17:02:11 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:11 INFO - '_': '/tools/buildbot/bin/python'} 17:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:12 INFO - Downloading/unpacking psutil>=3.1.1 17:02:12 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:02:12 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:02:12 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:02:12 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:02:12 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:02:12 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:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:02:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:14 INFO - Installing collected packages: psutil 17:02:14 INFO - Running setup.py install for psutil 17:02:14 INFO - building 'psutil._psutil_linux' extension 17:02:14 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:02:14 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:02:14 INFO - building 'psutil._psutil_posix' extension 17:02:14 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:02:14 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:02:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:14 INFO - Successfully installed psutil 17:02:14 INFO - Cleaning up... 17:02:14 INFO - Return code: 0 17:02:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:02: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:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:14 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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:14 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:02:14 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:02:14 INFO - Using env: {'DISPLAY': ':0', 17:02:14 INFO - 'HOME': '/home/cltbld', 17:02:14 INFO - 'LANG': 'en_US.UTF-8', 17:02:14 INFO - 'LANGUAGE': 'en_US:en', 17:02:14 INFO - 'LOGNAME': 'cltbld', 17:02:14 INFO - 'MAIL': '/var/mail/cltbld', 17:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:14 INFO - 'MOZ_NO_REMOTE': '1', 17:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:14 INFO - 'NO_EM_RESTART': '1', 17:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:14 INFO - 'PWD': '/builds/slave/test', 17:02:14 INFO - 'SHELL': '/bin/bash', 17:02:14 INFO - 'SHLVL': '1', 17:02:14 INFO - 'TERM': 'linux', 17:02:14 INFO - 'TMOUT': '86400', 17:02:14 INFO - 'USER': 'cltbld', 17:02:14 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:14 INFO - '_': '/tools/buildbot/bin/python'} 17:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:02:16 INFO - Installing collected packages: mozsystemmonitor 17:02:16 INFO - Running setup.py install for mozsystemmonitor 17:02:16 INFO - Successfully installed mozsystemmonitor 17:02:16 INFO - Cleaning up... 17:02:17 INFO - Return code: 0 17:02:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:02:17 INFO - Using env: {'DISPLAY': ':0', 17:02:17 INFO - 'HOME': '/home/cltbld', 17:02:17 INFO - 'LANG': 'en_US.UTF-8', 17:02:17 INFO - 'LANGUAGE': 'en_US:en', 17:02:17 INFO - 'LOGNAME': 'cltbld', 17:02:17 INFO - 'MAIL': '/var/mail/cltbld', 17:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:17 INFO - 'MOZ_NO_REMOTE': '1', 17:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:17 INFO - 'NO_EM_RESTART': '1', 17:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:17 INFO - 'PWD': '/builds/slave/test', 17:02:17 INFO - 'SHELL': '/bin/bash', 17:02:17 INFO - 'SHLVL': '1', 17:02:17 INFO - 'TERM': 'linux', 17:02:17 INFO - 'TMOUT': '86400', 17:02:17 INFO - 'USER': 'cltbld', 17:02:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:17 INFO - '_': '/tools/buildbot/bin/python'} 17:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:02:17 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:02:17 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:02:17 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:02:17 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:02:17 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:02:17 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:02:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:02:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:02:19 INFO - warning: no files found matching '*.txt' 17:02:19 INFO - no previously-included directories found matching 'build' 17:02:19 INFO - no previously-included directories found matching 'dist' 17:02:19 INFO - no previously-included directories found matching '.git*' 17:02:19 INFO - Installing collected packages: jsonschema, functools32 17:02:19 INFO - Running setup.py install for functools32 17:02:19 INFO - warning: no files found matching '*.txt' 17:02:19 INFO - no previously-included directories found matching 'build' 17:02:19 INFO - no previously-included directories found matching 'dist' 17:02:19 INFO - no previously-included directories found matching '.git*' 17:02:19 INFO - Successfully installed jsonschema functools32 17:02:19 INFO - Cleaning up... 17:02:19 INFO - Return code: 0 17:02:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:19 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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:19 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:02:19 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:02:19 INFO - Using env: {'DISPLAY': ':0', 17:02:19 INFO - 'HOME': '/home/cltbld', 17:02:19 INFO - 'LANG': 'en_US.UTF-8', 17:02:19 INFO - 'LANGUAGE': 'en_US:en', 17:02:19 INFO - 'LOGNAME': 'cltbld', 17:02:19 INFO - 'MAIL': '/var/mail/cltbld', 17:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:19 INFO - 'MOZ_NO_REMOTE': '1', 17:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:19 INFO - 'NO_EM_RESTART': '1', 17:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:19 INFO - 'PWD': '/builds/slave/test', 17:02:19 INFO - 'SHELL': '/bin/bash', 17:02:19 INFO - 'SHLVL': '1', 17:02:19 INFO - 'TERM': 'linux', 17:02:19 INFO - 'TMOUT': '86400', 17:02:19 INFO - 'USER': 'cltbld', 17:02:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:19 INFO - '_': '/tools/buildbot/bin/python'} 17:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:21 INFO - Downloading blobuploader-1.2.4.tar.gz 17:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:02:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:21 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:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:02:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:22 INFO - Downloading docopt-0.6.1.tar.gz 17:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:02:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:02:22 INFO - Running setup.py install for blobuploader 17:02:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:02:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:02:22 INFO - Running setup.py install for requests 17:02:22 INFO - Running setup.py install for docopt 17:02:23 INFO - Successfully installed blobuploader requests docopt 17:02:23 INFO - Cleaning up... 17:02:23 INFO - Return code: 0 17:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02: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:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02: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:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:23 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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:23 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:02:23 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:02:23 INFO - Using env: {'DISPLAY': ':0', 17:02:23 INFO - 'HOME': '/home/cltbld', 17:02:23 INFO - 'LANG': 'en_US.UTF-8', 17:02:23 INFO - 'LANGUAGE': 'en_US:en', 17:02:23 INFO - 'LOGNAME': 'cltbld', 17:02:23 INFO - 'MAIL': '/var/mail/cltbld', 17:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:23 INFO - 'MOZ_NO_REMOTE': '1', 17:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:23 INFO - 'NO_EM_RESTART': '1', 17:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:23 INFO - 'PWD': '/builds/slave/test', 17:02:23 INFO - 'SHELL': '/bin/bash', 17:02:23 INFO - 'SHLVL': '1', 17:02:23 INFO - 'TERM': 'linux', 17:02:23 INFO - 'TMOUT': '86400', 17:02:23 INFO - 'USER': 'cltbld', 17:02:23 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:23 INFO - '_': '/tools/buildbot/bin/python'} 17:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:23 INFO - Running setup.py (path:/tmp/pip-9zrElY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:23 INFO - Running setup.py (path:/tmp/pip-1zf0qU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:23 INFO - Running setup.py (path:/tmp/pip-Ft1LPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:23 INFO - Running setup.py (path:/tmp/pip-WEX5Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:23 INFO - Running setup.py (path:/tmp/pip-KvvxL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:23 INFO - Running setup.py (path:/tmp/pip-P6rQDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:23 INFO - Running setup.py (path:/tmp/pip-zmxxR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:23 INFO - Running setup.py (path:/tmp/pip-n_88bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:23 INFO - Running setup.py (path:/tmp/pip-1i13KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:23 INFO - Running setup.py (path:/tmp/pip-RvX_e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:24 INFO - Running setup.py (path:/tmp/pip-38ma1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:24 INFO - Running setup.py (path:/tmp/pip-n_lAXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:24 INFO - Running setup.py (path:/tmp/pip-8yZaWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:24 INFO - Running setup.py (path:/tmp/pip-_y26eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:24 INFO - Running setup.py (path:/tmp/pip-_jH0XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:24 INFO - Running setup.py (path:/tmp/pip-OnnoNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:24 INFO - Running setup.py (path:/tmp/pip-RMa2kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:02:24 INFO - Running setup.py install for manifestparser 17:02:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:02:24 INFO - Running setup.py install for mozcrash 17:02:24 INFO - Running setup.py install for mozdebug 17:02:24 INFO - Running setup.py install for mozdevice 17:02:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:02:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:02:24 INFO - Running setup.py install for mozfile 17:02:25 INFO - Running setup.py install for mozhttpd 17:02:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Running setup.py install for mozinfo 17:02:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Running setup.py install for mozInstall 17:02:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Running setup.py install for mozleak 17:02:25 INFO - Running setup.py install for mozlog 17:02:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Running setup.py install for moznetwork 17:02:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Running setup.py install for mozprocess 17:02:25 INFO - Running setup.py install for mozprofile 17:02:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Running setup.py install for mozrunner 17:02:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:02:25 INFO - Running setup.py install for mozscreenshot 17:02:26 INFO - Running setup.py install for moztest 17:02:26 INFO - Running setup.py install for mozversion 17:02:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:02:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:02:26 INFO - Cleaning up... 17:02:26 INFO - Return code: 0 17:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:26 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:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:26 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:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:26 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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:26 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:02:26 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:02:26 INFO - Using env: {'DISPLAY': ':0', 17:02:26 INFO - 'HOME': '/home/cltbld', 17:02:26 INFO - 'LANG': 'en_US.UTF-8', 17:02:26 INFO - 'LANGUAGE': 'en_US:en', 17:02:26 INFO - 'LOGNAME': 'cltbld', 17:02:26 INFO - 'MAIL': '/var/mail/cltbld', 17:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:26 INFO - 'MOZ_NO_REMOTE': '1', 17:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:26 INFO - 'NO_EM_RESTART': '1', 17:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:26 INFO - 'PWD': '/builds/slave/test', 17:02:26 INFO - 'SHELL': '/bin/bash', 17:02:26 INFO - 'SHLVL': '1', 17:02:26 INFO - 'TERM': 'linux', 17:02:26 INFO - 'TMOUT': '86400', 17:02:26 INFO - 'USER': 'cltbld', 17:02:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:26 INFO - '_': '/tools/buildbot/bin/python'} 17:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:26 INFO - Running setup.py (path:/tmp/pip-lQ2XDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:26 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:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:26 INFO - Running setup.py (path:/tmp/pip-mP5R6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:26 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:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:26 INFO - Running setup.py (path:/tmp/pip-wJxesj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:26 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:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:26 INFO - Running setup.py (path:/tmp/pip-o_Og6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:26 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:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:26 INFO - Running setup.py (path:/tmp/pip-KbbSxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:26 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:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:26 INFO - Running setup.py (path:/tmp/pip-VVooOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:26 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:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:26 INFO - Running setup.py (path:/tmp/pip-do3ezc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:27 INFO - Running setup.py (path:/tmp/pip-b3qx65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:27 INFO - Running setup.py (path:/tmp/pip-MBHFx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:27 INFO - Running setup.py (path:/tmp/pip-ocGvYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:27 INFO - Running setup.py (path:/tmp/pip-WwMHKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:27 INFO - Running setup.py (path:/tmp/pip-yoFk7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:27 INFO - Running setup.py (path:/tmp/pip-SAdV2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:27 INFO - Running setup.py (path:/tmp/pip-PqlEFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:27 INFO - Running setup.py (path:/tmp/pip-zA_SGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:27 INFO - Running setup.py (path:/tmp/pip-R_S7cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:27 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:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:27 INFO - Running setup.py (path:/tmp/pip-6Msq8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:27 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:02:27 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:02:27 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:02:27 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:02:27 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:02:27 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:02:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02: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:02: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:02: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:02: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:02: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:02: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:02:29 INFO - Downloading blessings-1.6.tar.gz 17:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:02:29 INFO - Installing collected packages: blessings 17:02:29 INFO - Running setup.py install for blessings 17:02:29 INFO - Successfully installed blessings 17:02:29 INFO - Cleaning up... 17:02:29 INFO - Return code: 0 17:02:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:30 INFO - Reading from file tmpfile_stdout 17:02:30 INFO - Current package versions: 17:02:30 INFO - argparse == 1.2.1 17:02:30 INFO - blessings == 1.6 17:02:30 INFO - blobuploader == 1.2.4 17:02:30 INFO - docopt == 0.6.1 17:02:30 INFO - functools32 == 3.2.3-2 17:02:30 INFO - jsonschema == 2.5.1 17:02:30 INFO - manifestparser == 1.1 17:02:30 INFO - mozInstall == 1.12 17:02:30 INFO - mozcrash == 0.17 17:02:30 INFO - mozdebug == 0.1 17:02:30 INFO - mozdevice == 0.48 17:02:30 INFO - mozfile == 1.2 17:02:30 INFO - mozhttpd == 0.7 17:02:30 INFO - mozinfo == 0.9 17:02:30 INFO - mozleak == 0.1 17:02:30 INFO - mozlog == 3.2 17:02:30 INFO - moznetwork == 0.27 17:02:30 INFO - mozprocess == 0.22 17:02:30 INFO - mozprofile == 0.28 17:02:30 INFO - mozrunner == 6.11 17:02:30 INFO - mozscreenshot == 0.1 17:02:30 INFO - mozsystemmonitor == 0.3 17:02:30 INFO - moztest == 0.7 17:02:30 INFO - mozversion == 1.4 17:02:30 INFO - psutil == 3.1.1 17:02:30 INFO - requests == 1.2.3 17:02:30 INFO - wsgiref == 0.1.2 17:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:30 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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:30 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:02:30 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:02:30 INFO - Using env: {'DISPLAY': ':0', 17:02:30 INFO - 'HOME': '/home/cltbld', 17:02:30 INFO - 'LANG': 'en_US.UTF-8', 17:02:30 INFO - 'LANGUAGE': 'en_US:en', 17:02:30 INFO - 'LOGNAME': 'cltbld', 17:02:30 INFO - 'MAIL': '/var/mail/cltbld', 17:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:30 INFO - 'MOZ_NO_REMOTE': '1', 17:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:30 INFO - 'NO_EM_RESTART': '1', 17:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:30 INFO - 'PWD': '/builds/slave/test', 17:02:30 INFO - 'SHELL': '/bin/bash', 17:02:30 INFO - 'SHLVL': '1', 17:02:30 INFO - 'TERM': 'linux', 17:02:30 INFO - 'TMOUT': '86400', 17:02:30 INFO - 'USER': 'cltbld', 17:02:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:30 INFO - '_': '/tools/buildbot/bin/python'} 17:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:30 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:02:30 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:02:30 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:02:30 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:02:30 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:02:30 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:02:30 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:02:30 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:02:30 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:02:30 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:02:30 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:02:30 INFO - Cleaning up... 17:02:30 INFO - Return code: 0 17:02:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:30 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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:30 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:02:30 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:02:30 INFO - Using env: {'DISPLAY': ':0', 17:02:30 INFO - 'HOME': '/home/cltbld', 17:02:30 INFO - 'LANG': 'en_US.UTF-8', 17:02:30 INFO - 'LANGUAGE': 'en_US:en', 17:02:30 INFO - 'LOGNAME': 'cltbld', 17:02:30 INFO - 'MAIL': '/var/mail/cltbld', 17:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:30 INFO - 'MOZ_NO_REMOTE': '1', 17:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:30 INFO - 'NO_EM_RESTART': '1', 17:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:30 INFO - 'PWD': '/builds/slave/test', 17:02:30 INFO - 'SHELL': '/bin/bash', 17:02:30 INFO - 'SHLVL': '1', 17:02:30 INFO - 'TERM': 'linux', 17:02:30 INFO - 'TMOUT': '86400', 17:02:30 INFO - 'USER': 'cltbld', 17:02:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:30 INFO - '_': '/tools/buildbot/bin/python'} 17:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:02:30 INFO - Cleaning up... 17:02:30 INFO - Return code: 0 17:02:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:30 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 0x7f3d88f50f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c83350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, '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': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', '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:02:30 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:02:30 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:02:30 INFO - Using env: {'DISPLAY': ':0', 17:02:30 INFO - 'HOME': '/home/cltbld', 17:02:30 INFO - 'LANG': 'en_US.UTF-8', 17:02:30 INFO - 'LANGUAGE': 'en_US:en', 17:02:30 INFO - 'LOGNAME': 'cltbld', 17:02:30 INFO - 'MAIL': '/var/mail/cltbld', 17:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:30 INFO - 'MOZ_NO_REMOTE': '1', 17:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:30 INFO - 'NO_EM_RESTART': '1', 17:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:30 INFO - 'PWD': '/builds/slave/test', 17:02:30 INFO - 'SHELL': '/bin/bash', 17:02:30 INFO - 'SHLVL': '1', 17:02:30 INFO - 'TERM': 'linux', 17:02:30 INFO - 'TMOUT': '86400', 17:02:30 INFO - 'USER': 'cltbld', 17:02:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:30 INFO - '_': '/tools/buildbot/bin/python'} 17:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:30 INFO - Downloading/unpacking flake8 17:02: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:02: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:02: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:02: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:02: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:02: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:02:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:02:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:02:32 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:02:32 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:02:32 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:02:32 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:02:32 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:02:32 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:02:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:02:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:02:32 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:02:32 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:02:32 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:02:32 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:02:32 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:02:32 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:02:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:02:33 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:02:33 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:02:33 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:02:33 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:02:33 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:02:33 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:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:02:33 INFO - no previously-included directories found matching 'docs/_build' 17:02:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:02:33 INFO - Running setup.py install for pep8 17:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:02:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:02:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:02:33 INFO - no previously-included directories found matching 'docs/_build' 17:02:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:02:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:02:33 INFO - Cleaning up... 17:02:33 INFO - Return code: 0 17:02:33 INFO - Running post-action listener: _resource_record_post_action 17:02:33 INFO - Running post-action listener: _start_resource_monitoring 17:02:33 INFO - Starting resource monitoring. 17:02:33 INFO - ##### 17:02:33 INFO - ##### Finished create-virtualenv step (success) 17:02:33 INFO - ##### 17:02:33 INFO - ##### 17:02:33 INFO - ##### Running install step. 17:02:33 INFO - ##### 17:02:33 INFO - Running pre-action listener: _resource_record_pre_action 17:02:33 INFO - Running main action method: install 17:02:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:33 INFO - Reading from file tmpfile_stdout 17:02:33 INFO - Detecting whether we're running mozinstall >=1.0... 17:02:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:02:33 INFO - Reading from file tmpfile_stdout 17:02:33 INFO - Output received: 17:02:33 INFO - Usage: mozinstall [options] installer 17:02:33 INFO - Options: 17:02:33 INFO - -h, --help show this help message and exit 17:02:33 INFO - -d DEST, --destination=DEST 17:02:33 INFO - Directory to install application into. [default: 17:02:33 INFO - "/builds/slave/test"] 17:02:33 INFO - --app=APP Application being installed. [default: firefox] 17:02:33 INFO - mkdir: /builds/slave/test/build/application 17:02:33 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:02:33 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:02:51 INFO - Reading from file tmpfile_stdout 17:02:51 INFO - Output received: 17:02:51 INFO - /builds/slave/test/build/application/firefox/firefox 17:02:51 INFO - Running post-action listener: _resource_record_post_action 17:02:51 INFO - ##### 17:02:51 INFO - ##### Finished install step (success) 17:02:51 INFO - ##### 17:02:51 INFO - ##### 17:02:51 INFO - ##### Running run-tests step. 17:02:51 INFO - ##### 17:02:51 INFO - Running pre-action listener: _resource_record_pre_action 17:02:51 INFO - Running main action method: run_tests 17:02:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:02:51 INFO - Python 2.7.3 17:02:51 INFO - Return code: 0 17:02:51 INFO - grabbing minidump binary from tooltool 17:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:02:51 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 0x1d121c0>, '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 0x1d130c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d13550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:02:51 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:02:51 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:02:51 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:02:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:02:51 INFO - Return code: 0 17:02:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:02:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:02:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:02:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:02:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:02:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:02:52 INFO - Return code: 0 17:02:52 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', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:02:52 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 --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-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:02:52 INFO - Using env: {'DISPLAY': ':0', 17:02:52 INFO - 'HOME': '/home/cltbld', 17:02:52 INFO - 'LANG': 'en_US.UTF-8', 17:02:52 INFO - 'LANGUAGE': 'en_US:en', 17:02:52 INFO - 'LOGNAME': 'cltbld', 17:02:52 INFO - 'MAIL': '/var/mail/cltbld', 17:02:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:02:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:52 INFO - 'MOZ_NO_REMOTE': '1', 17:02:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:52 INFO - 'NO_EM_RESTART': '1', 17:02:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:52 INFO - 'PWD': '/builds/slave/test', 17:02:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:02:52 INFO - 'SHELL': '/bin/bash', 17:02:52 INFO - 'SHLVL': '1', 17:02:52 INFO - 'TERM': 'linux', 17:02:52 INFO - 'TMOUT': '86400', 17:02:52 INFO - 'USER': 'cltbld', 17:02:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465257716.755680-558871115', 17:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:52 INFO - '_': '/tools/buildbot/bin/python'} 17:02:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:02:52 INFO - mozversion application_buildid: 20160606143009 17:02:52 INFO - mozversion application_changeset: 883b0a89b3212b6b55b7e6fde69d0438c39899ff 17:02:52 INFO - mozversion application_display_name: Nightly 17:02:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:02:52 INFO - mozversion application_name: Firefox 17:02:52 INFO - mozversion application_remotingname: firefox 17:02:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:02:52 INFO - mozversion application_vendor: Mozilla 17:02:52 INFO - mozversion application_version: 49.0a1 17:02:52 INFO - mozversion platform_buildid: 20160606143009 17:02:52 INFO - mozversion platform_changeset: 883b0a89b3212b6b55b7e6fde69d0438c39899ff 17:02:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:02:52 INFO - mozversion platform_version: 49.0a1 17:02:52 INFO - using testdate: 1465257772 17:02:52 INFO - actual date: 1465257772 17:02:52 INFO - starting webserver on 'localhost:47151' 17:02:52 INFO - SUITE-START | Running 2 tests 17:02:52 INFO - TEST-START | dromaeo_css 17:02:52 INFO - operating with platform_type : linux_ 17:02:52 INFO - Initialising browser for dromaeo_css test... 17:02:52 INFO - TEST-INFO | started process 984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzsgG76/profile http://localhost:47151/getInfo.html) 17:02:57 INFO - PROCESS | 984 | __metrics Screen width/height:1600/1200 17:02:57 INFO - PROCESS | 984 | colorDepth:24 17:02:57 INFO - PROCESS | 984 | Browser inner width/height: 1024/697 17:02:57 INFO - PROCESS | 984 | __metrics 17:02:58 ERROR - PROCESS | 984 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:02:58 INFO - PROCESS | 984 | console.error: PushService: 17:02:58 INFO - PROCESS | 984 | stateChangeProcessEnqueue: Error transitioning state 17:02:58 INFO - PROCESS | 984 | UnknownError 17:02:59 INFO - TEST-INFO | 984: exit 0 17:02:59 INFO - Browser initialized. 17:02:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:02:59 INFO - TEST-INFO | started process 1076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzsgG76/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:11 INFO - PROCESS | 1076 | RSS: Main: 156594176 17:03:11 INFO - PROCESS | 1076 | 17:04:02 INFO - PROCESS | 1076 | 1465257842066 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:06:10 INFO - PROCESS | 1076 | Cycle 1(1): loaded http://localhost:47151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47151/tests/dromaeo/cssquery-ext.html) 17:06:11 INFO - PROCESS | 1076 | RSS: Main: 274358272 17:06:11 INFO - PROCESS | 1076 | 17:09:13 INFO - PROCESS | 1076 | Cycle 1(1): loaded http://localhost:47151/tests/dromaeo/cssquery-ext.html (next: http://localhost:47151/tests/dromaeo/cssquery-jquery.html) 17:09:14 INFO - PROCESS | 1076 | RSS: Main: 247468032 17:09:14 INFO - PROCESS | 1076 | 17:12:16 INFO - PROCESS | 1076 | Cycle 1(1): loaded http://localhost:47151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47151/tests/dromaeo/cssquery-mootools.html) 17:12:16 INFO - PROCESS | 1076 | RSS: Main: 246669312 17:12:16 INFO - PROCESS | 1076 | 17:15:19 INFO - PROCESS | 1076 | Cycle 1(1): loaded http://localhost:47151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47151/tests/dromaeo/cssquery-prototype.html) 17:15:19 INFO - PROCESS | 1076 | RSS: Main: 231092224 17:15:19 INFO - PROCESS | 1076 | 17:18:22 INFO - PROCESS | 1076 | Cycle 1(1): loaded http://localhost:47151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47151/tests/dromaeo/cssquery-yui.html) 17:18:22 INFO - PROCESS | 1076 | RSS: Main: 221085696 17:18:22 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | Cycle 1(1): loaded http://localhost:47151/tests/dromaeo/cssquery-yui.html (next: http://localhost:47151/tests/dromaeo/cssquery-dojo.html) 17:21:26 INFO - PROCESS | 1076 | RSS: Main: 276942848 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | __start_tp_report 17:21:26 INFO - PROCESS | 1076 | _x_x_mozilla_page_load 17:21:26 INFO - PROCESS | 1076 | _x_x_mozilla_page_load_details 17:21:26 INFO - PROCESS | 1076 | |i|pagename|runs| 17:21:26 INFO - PROCESS | 1076 | |0;dojo.html;3123.2504198992237;3131.9686803131963;3156.7632427567937;3175.634801997771;3191.2341038150853;5287.603429742765;5313.814016509423;5362.490563396481;5419.051665958451;5431.402545719972;5362.383325917511;5404.729763511828;5439.700816455093;5561.054620714478;5572.275604171452;4794.400699912502;4830.227163653816;4844.442889067767;4925.605951523888;4957.702537847741;4995.725235112068;5018.172001619747;5045.217991211368;5053.77258023388;5085.389753229599;4788.688735232199;4825.517448255181;4965.37932758407;4969.975150124263;5003.349564556603;4868.099401610678;4902.289168070645;4917.065757506062;4935.457099719028;5011.599072074226;4912.754362281908;4913.361263035818;4918.065567542156;4926;4928.236123400879;5357.598180136505;5396.10964190908;5415.458454154593;5423.430539793344;5426.240326354314;5639.605227634067;5725.856853578653;5800.622959507618;5804.506616937565;5804.651720896717;5915.053591425351;5919.437653422918;5920.111983202511;5928.911066334009;5932.851678708023;5277;5476.644018138808;5517.227588137664;5521.337439507285;5524.475174858382;5809.564282678816;5851.180834683148;5881.588288819741;5943.673097979653;6002.699865006733;5699.658020518699;5743;5746.195532625436;5749.482546570829;5775.220345253337;5604;5801.6519008859605;5808.535317174616;5857.824265272048;5858.5898987070495;5652.180433837153;5720.713964301768;5722.141678748221;5738.913916291259;5749.367569567345;5770.624909380961;5790.739416726257;5793.188953546507;5794.88410231793;5797.188393624896;4323.0705398339505;4342.934855977162;4343.19650864591;4353.998580326479;4388.166248412791;3931.0565464288366;3936.822842972073;3941.507311586052;3972.7219094663674;3989.880303590897;5413.864653383618;5414.29614150158;5422.539084177889;5430.456954304538;5483.2049352844415;5580.218769372291;5729.48434640876;5813.069908814569;5844.9415505845245;5860.09168578871;5468.207109969032;5469.316335458067;5487.204355368449;5499.835004949778;5516.172574113915;4864.78108485119;4979.30289759434;4987.650864439527;4993.550580447704;5034.295198672189;5805.477507024304;5883.676397798162;5986.2517185351835;5989.55078369124;5992.820215393545;5732.914006289992;5857.121431785266;5870.911936321044;5876.6180198288685;5917.467427931335;5910.645361278337;5939.881202376015;5946.43508866657;5959.255093113361;5971.4327138921735;5544.667319960815;5686.800961966312;5726.284214473191;5731.8853622928145;5741.598088133791;5923.526117910643;5952.821415357546;5964.224650795369;5969.283685957713;5995.850103747442;5791.0734282514595;5796.82609521715;5800.24596802413;5802.912956305574;5806.071028635398;5463.399026107205;5536.4186760389575;5575.080111781511;5646.209530665628;5721.656700597978;5583.385827559046;5584.190292407659;5587.832365029056;5589.552835773047;5592.748326325243;5736.5984381094595;5752.194692743103;5792.855178620568;5796.971015145066;5797.9420205797405;5401.648892821954;5440.591955603267;5453.945460545344;5477.4248703887115;5493.807716729895 17:21:26 INFO - PROCESS | 1076 | |1;ext.html;577.8150991682661;623.155624129305;623.17429406037;633.3223450907531;634.6255709131613;31209.843950780243;44316;45295.54704452954;45335;45362.54637453624;45760.084798304015;46265.30602040972;46302;46336;46352.76823615877;8046.235607617267;8261.215184557488;8270;8708.95645521773;8907.198352148305;8173.591320433984;10273.407621818593;10634.78730425391;10658.946705266462;11044.061254793352;10825.729356766104;10893.618723344685;10901.345919244832;10905.18211134164;10908.563657453731;8070.919290807075;8319.168083191693;10667.413292268922;10788.460576971198;10795.892041079607;8301.792455188608;10039.34744241622;10470.47647617616;10475.161987041018;10748.838767418494;42758;43125.56874431247;43140;43251.13497730059;43302.35046474305;3150.401423729484;3178.698023687746;3350.6816852398983;3510.1224693826543;3612.801295928723;31981.840090799396;32750.672493275;32859;33202.16994575131;33489.330213395595;4269.466316710411;4328.870133895988;4332.71593873855;4348.4999225089205;4525.208088584484;356491;357079;357243;357857;358283;58730.412695872496;58966.41033589609;59223;59343.40656593379;59343.40656593379;35578.37481127437;36586.451203231976;36828.07929801723;38730.80634596809;38793.67237965731;17242.913785430992;17347.479575612753;17388.82611173872;17421.390251341396;17422.738658920127;12220.205686630341;13042.934785326202;13307.66730831737;13426.530071447452;13457.663558411117;19589.804101959082;19781.20875165006;19797.20811167566;19876.50308742293;19888.10503527345;6829.419499342612;6840.452763778985;6933.237343892168;6951.3396227359335;7091;1005.4922264256504;1048.292402628238;1094.6497120921388;1136.3409222650844;1191.362620997762;33044.1738956528;33074.83462582672;33176;33237.833810830794;33999;1084.6312253833735;1125.1729978465821;1125.6285425809463;1140.1904647700226;1209.2079687804503;17046.147692615566;17589.20848561818;17640;17646.647067058588;17739.733903991193;591565;593997;594133;597730;600708;59230.70384648135;60571.39428605745;60745;60808.695956519936;60828.69585652043;1279.5649479177125;1370.0615078671142;1394.7977543256375;1400.3978289335682;1411.3155119766905;32146;34337.14157145991;34367;34623;34816;51249.74375128101;51503.484965149866;51891.481085188665;51899;51912.74043629758;428266;429928;430347;431103;431423;25059.248222553353;27045.188644340702;28145.296367590974;28299;29909.102726918227;48114;48921.75539122282;49043.50956490532;49983.25025124553;50078;41255.7937210312;41480.1703965913;41675.7916210417;42590;42624.14751705011;40876.79561602173;41111.7944410276;41424.58575414207;42101.78949105235;42269;41264.1747165061;41951.58048419477;42238;42545.78727106345;42713.359299611155;35928.82035589805;37059.7733441987;37194.25611487701;37792.244155117296;37864.43203351897;28078.85960570184;28210;28426.715732842407;28553;28681 17:21:26 INFO - PROCESS | 1076 | |2;jquery.html;393.18021924287876;394.74933417280016;395.48389351895776;401.4399912122589;419.75444365046445;17863.285468581256;19001.809981900176;19403.708944365844;19411.12649930753;19421.22315107394;17455.73816392752;18644.627107457844;18849.151788169533;19805.405837824852;19806.504837379038;5675.829725108243;5784.045632470637;5818.854528636797;5829.213056237418;5874.324452687932;5669.376368599451;5760.596758226926;5781.075027995522;5790.507806836424;5802.100674395476;5670.546356291507;5736.426357364272;5783.797567085153;5805.709714514257;5817.796377126801;5706.600537962344;5737.799177028825;5780.1907732917425;5788.47903688668;5823.708814559276;4913.680610760289;5230.189320655304;5234.241035049897;5284.815031473919;5294.205869119624;21393.893030534902;21596.244131455325;21738;21757.694538327592;21857;2159.91360345586;2173.913043478259;2181.4982554012668;2231.4086767006756;2773.833569985807;9486.525673716356;9574.617015319378;9870.654527091589;9929.156021738161;10124.392536447836;1696.9236384362732;1799.073477159264;1806.4309742431092;1867.7385166076624;1916.4633902507321;80801.59599202026;83006.16993830045;83110.58444707798;85228.14771852264;87820;10365.689029329133;10418.426986515662;10522.368657880552;10622.309549879234;10651.082805095157;14970;14994.925025374803;15010.849891501164;15069.17119558413;15204.239788010776;7753.8449231015065;8094.716684915999;8161.306288965386;8340.41617086798;8344.998600168019;7856.646450909723;7886.684532618746;7901.762947111596;8094.635741391651;8152.959235203786;4466.39703640011;4551.817927282872;4608.585227329557;4657.74382408964;4744.95255047452;1932.951676208106;1943.9028048597513;1956.4717526267827;1965.3809050149157;1979.4465139969566;900.320258205051;965.285688590438;1008.969730908074;1018.3686114608989;1026.1431704526653;18503.35238266654;18658.720119198224;18873.150708218163;18896.811031889505;19435.22259109648;947.0387556630026;947.9478628675352;954.4082668745283;983.041534503853;993.0516356879308;10337.586496540205;10619.575216991389;10699.518521666543;10719.088877445505;10741.516631751434;504920;508565.28384170716;513189;518221;520082;92179;92193;92748;93191.53404232935;94346.52826735823;963.330485312701;973.4159504297365;991.3258983890879;991.5290237137447;993.5082134343546;16400.917995409945;16696.749548757023;16985.32058717687;17033.82966170372;17306.740398893773;38715.80642096772;39480;40423;41195.58804411918;43421.131577368906;56214.718926405105;57352.42647573471;58618;58739.4126058734;59424.40575594362;8414.747557573282;8720.91279087201;8764.430312029697;8772.649094036422;8829.514376709343;9943.801123977335;13400.865991340352;13623.38694758758;13676.52132175409;13822.723545529234;11128.888711112786;11480.770384592428;11573;11634.011109055487;11881.1089168311;11746.823797642872;11830.994365478686;11842;12178.939105304416;12225.388730563614;10801.082785495646;11622;11740;11774.94112529432;11863;8438.493690378597;8694.521801300736;8734.868976965477;8739.519326436852;8808.20726134651;8767.517786521548;11188.776224475629;11529.135314851252;11917;11996.220245684002 17:21:26 INFO - PROCESS | 1076 | |3;mootools.html;1253.1791676451917;1471.8307394649614;1488.0327786938492;1656.9502914912557;1826.6164105537844;8154.225348591882;8567.871481927768;8571.528565928878;8811.559422028906;8813.4711917285;8534.74395768128;8718.782030449242;8733.519656418894;8737.38838281319;8739.606717697703;2090.163934426234;2291.679164916913;2317.640765681318;2364.7517010713887;2376.2396033269274;2396.9041238350446;2404.1345115758313;2415.335782659765;2416.565018296706;2420.5279970405777;2340.9531809363802;2359.6224604063354;2410.819188560865;2411.360989337827;2417.033186725306;2027.7972202779752;2190.6494960806353;2264.1509433962265;2266.172846910882;2296.781805728453;2347.1315613223046;2351.0595761695286;2372.632242002492;2380.8571485710913;2383.833131680783;8717.825643487158;8771.956140219258;8790.384673072887;8797.516136612483;8800.735977920673;5223.817166399196;5343.786248550054;5368.275282836806;5372.086745253317;5376.838694839161;3321.7674762766615;3406.131436483706;3495.4931534927546;3507.8947631571095;3533.116720819795;1209.866914639389;1249.3066348176758;1250.1374051904156;1259.1563652352945;1274.0953922714884;12205.93897030518;12250.44872980709;12269.693257668541;12282.508699652004;12303.630891073193;4652.043645687153;4803.519648035169;4817.494163112893;4827.927581086216;4885.5358740919555;10181.643642472625;10236.283460157867;10236.53935572901;10240;10240.334378265537;5364.927014597019;5407.783688652488;5415.620906536584;5416.295881535454;5419.105847535113;4340.457442819647;4807.134715751128;4959.900801984012;4968.080905032581;5027.698338099725;3884;4020.7386519876113;4036.4348991141264;4090.7341022834016;4117.258893399157;1270.7712611729792;1282.4741855839247;1283.6020833541445;1294.976968195134;1306.301128896036;980.1962390839585;980.9166220871306;995.8655581496405;1000.4697510319543;1005.8491226316111;5877.177195192677;5892.823215303548;5940.376260492672;5961.940380596138;6037.607555508966;472.822691490691;475.5102244687977;486.0667518364748;486.8101440438232;490.01506970987856;4014.6988975826343;4077.4699289092227;4085.8569950051606;4087.325591277406;4187.832486700559;10378.976099660495;10886.67339979786;10892.564297428014;10915;10942.069924056384;10324;10846.511906964206;10874.18443616732;10884.455777211107;10886.891131088747;7983.560904150328;8274.586270686441;8308.626111824982;8345.207205315606;8346.332293416512;5990.88018239624;6258.780942666985;6258.874822503433;6283.874322513433;6340.784769351234;9959.352642078242;10216.080552750289;10255.435951022766;10267.435291059064;10382.117520010883;10278.229132814919;10288.485575721033;10377.896221037692;10393.53229104677;10399.064084232456;7162.283771622796;7317.0487836580905;7322.926770732224;7641.45034449149;7872.72445464406;8151.714689985822;8232.83534329322;8482.448640838325;8501.95749021251;8753.956230218808;7383.667734951832;7383.8154046149275;7522.6614802335125;7721.305082542598;7843.960780196063;7463;7590.962045189739;7658.119316278699;7758;7779.57212353326;6753.662316884234;6784.118064651564;6814.557053791686;6815.556988795911;6818;5061.39263288393;5100.642954993264;5219.373675159005;5279.26090347344;5281.55106815925;5293.2589437479555;5370.731463426891;5390.892182156256;5399.568034557305;5442.6462279951675 17:21:26 INFO - PROCESS | 1076 | |4;prototype.html;305.770671996003;317.0583367398825;317.56493603762834;319.0985466058386;324.14102628035704;5385.219143224235;5396.109641909085;5421.403645598986;5426.131818908975;5431.049566325897;5304.867378315535;5333.38666053404;5383;5418.972905135469;5424.9186262206;3986.421968814527;4097.078157414588;4107.856225032125;4164.479440069991;4223.894402639928;4169.895752606179;4182.498100227962;4200.537940826506;4208.347706105558;4214.957850421502;4125.23683118624;4145.782006626456;4147.6474499667565;4175.311073672856;4176.206520761046;3996.260691772017;3998.280309544281;4163.5836416358125;4169.395437661552;4199.874003779892;3650.105724097613;3662.432322989941;3675;3680.411134218539;3703;5168.8966220675375;5202.843914682566;5204.739763011872;5219.582433405319;5270.420253772082;4543.636509079266;4732.881677958044;4736.123817093849;4745.857624271277;4756.762161891892;5589.189567512688;5641.492265696107;5654.264945557051;5674.404187560288;5728.255326807488;3822.2928758179546;3907.765534067965;3980.7014473914574;3992.261431635157;4021.4973128358956;5814.97092514539;5856.540253093668;5875.73671660595;5885.264341957255;5915.940840591625;4068.247374235776;4072.75563466193;4099.139180772071;4108.650764685035;4128.958710412858;4086.5504794472586;4114.485689288839;4159.982408531921;4187.45563076798;4199.4330765346895;4706.458757242893;4735.95264047362;4749.503906269514;4785.617150627942;4818.7831547580445;5688.203651488712;5691.971540142273;5695.971520142456;5702.600817942787;5725.8568535786935;1381.1989046353092;1387.2300873015372;1388.2966591632432;1400.8178936738364;1408.746425643394;888.5646033443566;902.8194361127801;903.9954800225956;910.6038873090095;999.5601935148657;5409.67305107364;5413.810516631899;5419.458054194549;5433.1850222466155;5441.156620723794;5725.53801865202;5774.220480235199;5784.929787989236;5813.767449302065;5836.737346819404;5233.162693968947;5440.755166017539;5497.835064948058;5557.332800159936;5563.190588752654;3110.9688903110678;3127.2799960022353;3135.325904930451;3165.572647692578;3173.444647186733;5746.885062298814;6116.908246376308;6142.907856382158;6144.78493252734;6168;6004.639721616717;6029;6051.394860513913;6094.35452427842;6102.511799056065;6019.819405417757;6022.969885150546;6064.75740970365;6155.692215389213;6167.660778657217;5601.551875850004;5894.2926848778425;5911.497522710446;5931.377205393372;5942.73257703413;5814.592978491465;5823.418597562384;5841.737121829443;5861.85693789724;5877.853053673522;5791.884162316815;6069.969650151721;6084.361142080195;6104.664243466652;6105;4140.8136633850945;4173.311403618369;4182.64447521964;4183.740779978899;4196.1607678463815;5939.455741507153;5964.940350596438;5978.701064946822;6007.879842403215;6009.2188015557695;5678.403767604507;5702.232307984538;5704.914426283692;5757.510611598061;5840.445157710011;5699.715014249354;5729.28383952006;5760.164776107525;5761.905238004766;5789.2184555086205;5175;5431.6740995540395;5673.978683836784;5696.060150075191;5702.429757024264;5774.220480235283;5777.3933736957015;5800.216970708901;5808.477237048517;5808.634970781778;5615.719214039364;5644.181593668977;5672.60291779588;5679.290088738908;5681.261436013458 17:21:26 INFO - PROCESS | 1076 | |5;yui.html;731.9304666056722;766.5592284436447;789.3409003482092;813.1096449387918;846.1158089796162;13381.799273010913;15277.618059548517;15394.307256173472;15445.22773861308;15464.381424742996;14750.852491475109;14783.482578109768;14885.479008234714;14919.850801491983;14952.925235373836;655.4919937048778;660.4683229999848;772.7334069745929;772.8145245141181;802.297989259398;800.8198155415043;806.9072056713494;808.3533173461237;810.9189081091903;811.7199566149669;687.7524091327118;847.0174597466939;847.5126802088793;847.5253857839599;847.995760021199;803.8392321535687;831.2145022953312;831.8170002599419;833.7207035643066;835.2649668291864;605.7153138025121;605.7243954000963;607.0408754168403;607.1954660075418;607.3713706313988;12897;12901;12925.418356173996;12964.351782410842;12968.416421261067;14117.364718587585;14159.292035398188;14400.927995360062;14800.925995369955;14960.775588366183;11024.779504409948;11332.320060796379;11741.29552226869;12529.248245105322;12624.74750504994;4560.384348112995;4618.815247390134;4619.953800461986;4645.976770116162;4673.275642275453;79121;80749.19250807534;80930.59534702289;81204.59397703032;82043;9712.660056897974;9843.704688859345;10119.291649584458;10399.272050956512;10532.262741608167;20525.17899284012;20592;20674.379768606967;20844.58310833775;20898.477538061365;8367.62345694433;8540.274076703425;8724.912750872538;8725.476471411735;8932.776680582907;4445.310976798602;4461.955380446219;4576.679632425698;4678;4860.489648586848;3460.3598334308235;3656.1956369598647;3663.212409331953;3665.4685070664605;3671.632836716307;619.2043224456552;619.5941658213877;650.7917466410797;651.4104735214638;684.1448189762797;649.3023716884377;704.7216349542005;707.3527722134293;721.8267615772177;724.8402555910501;9497;10813.351198928089;10852.131829453625;10859.728506787393;10954.452277386099;650.7279708712289;715.2132654080469;717.5228473065457;749.9137599176164;759.1421693486325;4760.571548560646;4905.7301848397965;5119.232115182678;5135.974320128375;5199.324087868553;78539;78866.6056669713;119244;121028;129205.35397322953;85767.5711621438;109982.45008775065;110255;110298.44850775856;110873.44563277133;53108.468915311125;54425;60282;87378.56310718406;87618.56190718878;9651.855222171533;9652.517374131125;9669.661561845302;9682.042939825733;9706.126448619658;43773;48862.75568622134;49299;50085.24872126848;50316.24525632045;65582.67208663926;65719;75422.6228868874;76401;77371.2262877364;13024.609261722164;13095.41070651842;13308.667283317995;13319.400626971616;13572.79640805369;15044.774328384865;15152.242387880342;15342.846571534588;15517.922410387875;15704.764428533352;13165.078444508792;13251.933740331237;13304.733905322033;13499.190048597116;13704.65738356549;14334.283285835458;14363.425462981364;14607.342669579682;14642;15108.244587770349;14075.155490670593;14094;14427.711445771236;14918.104913705212;14937.925310373379;10182.847257290998;10235.948820255851;10249.586348503783;10404.32989484853;10691.625793097204;10571.735706607089;10627.09669678086;11070.778584428106;11311.717207069889;11353.602623908124 17:21:26 INFO - PROCESS | 1076 | __end_tp_report 17:21:26 INFO - PROCESS | 1076 | __start_cc_report 17:21:26 INFO - PROCESS | 1076 | _x_x_mozilla_cycle_collect,992 17:21:26 INFO - PROCESS | 1076 | __end_cc_report 17:21:26 INFO - PROCESS | 1076 | __startTimestamp1465258886377__endTimestamp 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | ------- Summary: start ------- 17:21:26 INFO - PROCESS | 1076 | Number of tests: 6 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | [#0] dojo.html Cycles:165 Average:5384.09 Median:5572.28 stddev:616.75 (11.1%) stddev-sans-first:592.59 17:21:26 INFO - PROCESS | 1076 | Values: 3123.3 3132.0 3156.8 3175.6 3191.2 5287.6 5313.8 5362.5 5419.1 5431.4 5362.4 5404.7 5439.7 5561.1 5572.3 4794.4 4830.2 4844.4 4925.6 4957.7 4995.7 5018.2 5045.2 5053.8 5085.4 4788.7 4825.5 4965.4 4970.0 5003.3 4868.1 4902.3 4917.1 4935.5 5011.6 4912.8 4913.4 4918.1 4926.0 4928.2 5357.6 5396.1 5415.5 5423.4 5426.2 5639.6 5725.9 5800.6 5804.5 5804.7 5915.1 5919.4 5920.1 5928.9 5932.9 5277.0 5476.6 5517.2 5521.3 5524.5 5809.6 5851.2 5881.6 5943.7 6002.7 5699.7 5743.0 5746.2 5749.5 5775.2 5604.0 5801.7 5808.5 5857.8 5858.6 5652.2 5720.7 5722.1 5738.9 5749.4 5770.6 5790.7 5793.2 5794.9 5797.2 4323.1 4342.9 4343.2 4354.0 4388.2 3931.1 3936.8 3941.5 3972.7 3989.9 5413.9 5414.3 5422.5 5430.5 5483.2 5580.2 5729.5 5813.1 5844.9 5860.1 5468.2 5469.3 5487.2 5499.8 5516.2 4864.8 4979.3 4987.7 4993.6 5034.3 5805.5 5883.7 5986.3 5989.6 5992.8 5732.9 5857.1 5870.9 5876.6 5917.5 5910.6 5939.9 5946.4 5959.3 5971.4 5544.7 5686.8 5726.3 5731.9 5741.6 5923.5 5952.8 5964.2 5969.3 5995.9 5791.1 5796.8 5800.2 5802.9 5806.1 5463.4 5536.4 5575.1 5646.2 5721.7 5583.4 5584.2 5587.8 5589.6 5592.7 5736.6 5752.2 5792.9 5797.0 5797.9 5401.6 5440.6 5453.9 5477.4 5493.8 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | [#1] ext.html Cycles:180 Average:61877.61 Median:36943.93 stddev:125351.32 (339.3%) stddev-sans-first:125618.47 17:21:26 INFO - PROCESS | 1076 | Values: 577.8 623.2 623.2 633.3 634.6 31209.8 44316.0 45295.5 45335.0 45362.5 45760.1 46265.3 46302.0 46336.0 46352.8 8046.2 8261.2 8270.0 8709.0 8907.2 8173.6 10273.4 10634.8 10658.9 11044.1 10825.7 10893.6 10901.3 10905.2 10908.6 8070.9 8319.2 10667.4 10788.5 10795.9 8301.8 10039.3 10470.5 10475.2 10748.8 42758.0 43125.6 43140.0 43251.1 43302.4 3150.4 3178.7 3350.7 3510.1 3612.8 31981.8 32750.7 32859.0 33202.2 33489.3 4269.5 4328.9 4332.7 4348.5 4525.2 356491.0 357079.0 357243.0 357857.0 358283.0 58730.4 58966.4 59223.0 59343.4 59343.4 35578.4 36586.5 36828.1 38730.8 38793.7 17242.9 17347.5 17388.8 17421.4 17422.7 12220.2 13042.9 13307.7 13426.5 13457.7 19589.8 19781.2 19797.2 19876.5 19888.1 6829.4 6840.5 6933.2 6951.3 7091.0 1005.5 1048.3 1094.6 1136.3 1191.4 33044.2 33074.8 33176.0 33237.8 33999.0 1084.6 1125.2 1125.6 1140.2 1209.2 17046.1 17589.2 17640.0 17646.6 17739.7 591565.0 593997.0 594133.0 597730.0 600708.0 59230.7 60571.4 60745.0 60808.7 60828.7 1279.6 1370.1 1394.8 1400.4 1411.3 32146.0 34337.1 34367.0 34623.0 34816.0 51249.7 51503.5 51891.5 51899.0 51912.7 428266.0 429928.0 430347.0 431103.0 431423.0 25059.2 27045.2 28145.3 28299.0 29909.1 48114.0 48921.8 49043.5 49983.3 50078.0 41255.8 41480.2 41675.8 42590.0 42624.1 40876.8 41111.8 41424.6 42101.8 42269.0 41264.2 41951.6 42238.0 42545.8 42713.4 35928.8 37059.8 37194.3 37792.2 37864.4 28078.9 28210.0 28426.7 28553.0 28681.0 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | [#2] jquery.html Cycles:180 Average:29578.22 Median:21920.44 stddev:84560.26 (385.8%) stddev-sans-first:84769.07 17:21:26 INFO - PROCESS | 1076 | Values: 393.2 394.7 395.5 401.4 419.8 17863.3 19001.8 19403.7 19411.1 19421.2 17455.7 18644.6 18849.2 19805.4 19806.5 5675.8 5784.0 5818.9 5829.2 5874.3 5669.4 5760.6 5781.1 5790.5 5802.1 5670.5 5736.4 5783.8 5805.7 5817.8 5706.6 5737.8 5780.2 5788.5 5823.7 4913.7 5230.2 5234.2 5284.8 5294.2 21393.9 21596.2 21738.0 21757.7 21857.0 2159.9 2173.9 2181.5 2231.4 2773.8 9486.5 9574.6 9870.7 9929.2 10124.4 1696.9 1799.1 1806.4 1867.7 1916.5 80801.6 83006.2 83110.6 85228.1 87820.0 10365.7 10418.4 10522.4 10622.3 10651.1 14970.0 14994.9 15010.8 15069.2 15204.2 7753.8 8094.7 8161.3 8340.4 8345.0 7856.6 7886.7 7901.8 8094.6 8153.0 4466.4 4551.8 4608.6 4657.7 4745.0 1933.0 1943.9 1956.5 1965.4 1979.4 900.3 965.3 1009.0 1018.4 1026.1 18503.4 18658.7 18873.2 18896.8 19435.2 947.0 947.9 954.4 983.0 993.1 10337.6 10619.6 10699.5 10719.1 10741.5 504920.0 508565.3 513189.0 518221.0 520082.0 92179.0 92193.0 92748.0 93191.5 94346.5 963.3 973.4 991.3 991.5 993.5 16400.9 16696.7 16985.3 17033.8 17306.7 38715.8 39480.0 40423.0 41195.6 43421.1 56214.7 57352.4 58618.0 58739.4 59424.4 8414.7 8720.9 8764.4 8772.6 8829.5 9943.8 13400.9 13623.4 13676.5 13822.7 11128.9 11480.8 11573.0 11634.0 11881.1 11746.8 11831.0 11842.0 12178.9 12225.4 10801.1 11622.0 11740.0 11774.9 11863.0 8438.5 8694.5 8734.9 8739.5 8808.2 8767.5 11188.8 11529.1 11917.0 11996.2 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | [#3] mootools.html Cycles:180 Average:5797.55 Median:4805.33 stddev:3280.85 (68.3%) stddev-sans-first:3272.27 17:21:26 INFO - PROCESS | 1076 | Values: 1253.2 1471.8 1488.0 1657.0 1826.6 8154.2 8567.9 8571.5 8811.6 8813.5 8534.7 8718.8 8733.5 8737.4 8739.6 2090.2 2291.7 2317.6 2364.8 2376.2 2396.9 2404.1 2415.3 2416.6 2420.5 2341.0 2359.6 2410.8 2411.4 2417.0 2027.8 2190.6 2264.2 2266.2 2296.8 2347.1 2351.1 2372.6 2380.9 2383.8 8717.8 8772.0 8790.4 8797.5 8800.7 5223.8 5343.8 5368.3 5372.1 5376.8 3321.8 3406.1 3495.5 3507.9 3533.1 1209.9 1249.3 1250.1 1259.2 1274.1 12205.9 12250.4 12269.7 12282.5 12303.6 4652.0 4803.5 4817.5 4827.9 4885.5 10181.6 10236.3 10236.5 10240.0 10240.3 5364.9 5407.8 5415.6 5416.3 5419.1 4340.5 4807.1 4959.9 4968.1 5027.7 3884.0 4020.7 4036.4 4090.7 4117.3 1270.8 1282.5 1283.6 1295.0 1306.3 980.2 980.9 995.9 1000.5 1005.8 5877.2 5892.8 5940.4 5961.9 6037.6 472.8 475.5 486.1 486.8 490.0 4014.7 4077.5 4085.9 4087.3 4187.8 10379.0 10886.7 10892.6 10915.0 10942.1 10324.0 10846.5 10874.2 10884.5 10886.9 7983.6 8274.6 8308.6 8345.2 8346.3 5990.9 6258.8 6258.9 6283.9 6340.8 9959.4 10216.1 10255.4 10267.4 10382.1 10278.2 10288.5 10377.9 10393.5 10399.1 7162.3 7317.0 7322.9 7641.5 7872.7 8151.7 8232.8 8482.4 8502.0 8754.0 7383.7 7383.8 7522.7 7721.3 7844.0 7463.0 7591.0 7658.1 7758.0 7779.6 6753.7 6784.1 6814.6 6815.6 6818.0 5061.4 5100.6 5219.4 5279.3 5281.6 5293.3 5370.7 5390.9 5399.6 5442.6 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | [#4] prototype.html Cycles:180 Average:4781.46 Median:5432.43 stddev:1438.25 (26.5%) stddev-sans-first:1402.50 17:21:26 INFO - PROCESS | 1076 | Values: 305.8 317.1 317.6 319.1 324.1 5385.2 5396.1 5421.4 5426.1 5431.0 5304.9 5333.4 5383.0 5419.0 5424.9 3986.4 4097.1 4107.9 4164.5 4223.9 4169.9 4182.5 4200.5 4208.3 4215.0 4125.2 4145.8 4147.6 4175.3 4176.2 3996.3 3998.3 4163.6 4169.4 4199.9 3650.1 3662.4 3675.0 3680.4 3703.0 5168.9 5202.8 5204.7 5219.6 5270.4 4543.6 4732.9 4736.1 4745.9 4756.8 5589.2 5641.5 5654.3 5674.4 5728.3 3822.3 3907.8 3980.7 3992.3 4021.5 5815.0 5856.5 5875.7 5885.3 5915.9 4068.2 4072.8 4099.1 4108.7 4129.0 4086.6 4114.5 4160.0 4187.5 4199.4 4706.5 4736.0 4749.5 4785.6 4818.8 5688.2 5692.0 5696.0 5702.6 5725.9 1381.2 1387.2 1388.3 1400.8 1408.7 888.6 902.8 904.0 910.6 999.6 5409.7 5413.8 5419.5 5433.2 5441.2 5725.5 5774.2 5784.9 5813.8 5836.7 5233.2 5440.8 5497.8 5557.3 5563.2 3111.0 3127.3 3135.3 3165.6 3173.4 5746.9 6116.9 6142.9 6144.8 6168.0 6004.6 6029.0 6051.4 6094.4 6102.5 6019.8 6023.0 6064.8 6155.7 6167.7 5601.6 5894.3 5911.5 5931.4 5942.7 5814.6 5823.4 5841.7 5861.9 5877.9 5791.9 6070.0 6084.4 6104.7 6105.0 4140.8 4173.3 4182.6 4183.7 4196.2 5939.5 5964.9 5978.7 6007.9 6009.2 5678.4 5702.2 5704.9 5757.5 5840.4 5699.7 5729.3 5760.2 5761.9 5789.2 5175.0 5431.7 5674.0 5696.1 5702.4 5774.2 5777.4 5800.2 5808.5 5808.6 5615.7 5644.2 5672.6 5679.3 5681.3 17:21:26 INFO - PROCESS | 1076 | 17:21:26 INFO - PROCESS | 1076 | [#5] yui.html Cycles:180 Average:20183.03 Median:4632.97 stddev:29093.35 (628.0%) stddev-sans-first:29138.31 17:21:26 INFO - PROCESS | 1076 | Values: 731.9 766.6 789.3 813.1 846.1 13381.8 15277.6 15394.3 15445.2 15464.4 14750.9 14783.5 14885.5 14919.9 14952.9 655.5 660.5 772.7 772.8 802.3 800.8 806.9 808.4 810.9 811.7 687.8 847.0 847.5 847.5 848.0 803.8 831.2 831.8 833.7 835.3 605.7 605.7 607.0 607.2 607.4 12897.0 12901.0 12925.4 12964.4 12968.4 14117.4 14159.3 14400.9 14800.9 14960.8 11024.8 11332.3 11741.3 12529.2 12624.7 4560.4 4618.8 4620.0 4646.0 4673.3 79121.0 80749.2 80930.6 81204.6 82043.0 9712.7 9843.7 10119.3 10399.3 10532.3 20525.2 20592.0 20674.4 20844.6 20898.5 8367.6 8540.3 8724.9 8725.5 8932.8 4445.3 4462.0 4576.7 4678.0 4860.5 3460.4 3656.2 3663.2 3665.5 3671.6 619.2 619.6 650.8 651.4 684.1 649.3 704.7 707.4 721.8 724.8 9497.0 10813.4 10852.1 10859.7 10954.5 650.7 715.2 717.5 749.9 759.1 4760.6 4905.7 5119.2 5136.0 5199.3 78539.0 78866.6 119244.0 121028.0 129205.4 85767.6 109982.5 110255.0 110298.4 110873.4 53108.5 54425.0 60282.0 87378.6 87618.6 9651.9 9652.5 9669.7 9682.0 9706.1 43773.0 48862.8 49299.0 50085.2 50316.2 65582.7 65719.0 75422.6 76401.0 77371.2 13024.6 13095.4 13308.7 13319.4 13572.8 15044.8 15152.2 15342.8 15517.9 15704.8 13165.1 13251.9 13304.7 13499.2 13704.7 14334.3 14363.4 14607.3 14642.0 15108.2 14075.2 14094.0 14427.7 14918.1 14937.9 10182.8 10235.9 10249.6 10404.3 10691.6 10571.7 10627.1 11070.8 11311.7 11353.6 17:21:26 INFO - PROCESS | 1076 | -------- Summary: end -------- 17:21:26 INFO - PROCESS | 1076 | 17:21:27 INFO - TEST-INFO | 1076: exit 0 17:21:27 INFO - TEST-OK | dromaeo_css | took 1114348ms 17:21:27 INFO - TEST-START | kraken 17:21:27 INFO - operating with platform_type : linux_ 17:21:27 INFO - Initialising browser for kraken test... 17:21:27 INFO - TEST-INFO | started process 1331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDc2ea/profile http://localhost:47151/getInfo.html) 17:21:31 INFO - PROCESS | 1331 | __metrics Screen width/height:1600/1200 17:21:31 INFO - PROCESS | 1331 | colorDepth:24 17:21:31 INFO - PROCESS | 1331 | Browser inner width/height: 1024/697 17:21:31 INFO - PROCESS | 1331 | __metrics 17:21:32 ERROR - PROCESS | 1331 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:21:32 INFO - PROCESS | 1331 | console.error: PushService: 17:21:32 INFO - PROCESS | 1331 | stateChangeProcessEnqueue: Error transitioning state 17:21:32 INFO - PROCESS | 1331 | UnknownError 17:21:33 INFO - TEST-INFO | 1331: exit 0 17:21:33 INFO - Browser initialized. 17:21:33 INFO - Running cycle 1/1 for kraken test... 17:21:33 INFO - TEST-INFO | started process 1415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDc2ea/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:45 INFO - PROCESS | 1415 | RSS: Main: 160751616 17:21:45 INFO - PROCESS | 1415 | 17:21:47 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47151/tests/kraken/driver.html?testName=audio-beat-detection) 17:21:48 INFO - PROCESS | 1415 | RSS: Main: 219017216 17:21:48 INFO - PROCESS | 1415 | 17:21:51 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47151/tests/kraken/driver.html?testName=audio-dft) 17:21:51 INFO - PROCESS | 1415 | RSS: Main: 206004224 17:21:51 INFO - PROCESS | 1415 | 17:21:54 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47151/tests/kraken/driver.html?testName=audio-fft) 17:21:55 INFO - PROCESS | 1415 | RSS: Main: 272515072 17:21:55 INFO - PROCESS | 1415 | 17:21:57 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47151/tests/kraken/driver.html?testName=audio-oscillator) 17:21:58 INFO - PROCESS | 1415 | RSS: Main: 183648256 17:21:58 INFO - PROCESS | 1415 | 17:22:00 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:00 INFO - PROCESS | 1415 | RSS: Main: 188678144 17:22:00 INFO - PROCESS | 1415 | 17:22:04 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47151/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:04 INFO - PROCESS | 1415 | RSS: Main: 223412224 17:22:04 INFO - PROCESS | 1415 | 17:22:08 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47151/tests/kraken/driver.html?testName=imaging-desaturate) 17:22:08 INFO - PROCESS | 1415 | RSS: Main: 224804864 17:22:08 INFO - PROCESS | 1415 | 17:22:11 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47151/tests/kraken/driver.html?testName=json-parse-financial) 17:22:12 INFO - PROCESS | 1415 | RSS: Main: 224792576 17:22:12 INFO - PROCESS | 1415 | 17:22:13 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:14 INFO - PROCESS | 1415 | RSS: Main: 209727488 17:22:14 INFO - PROCESS | 1415 | 17:22:15 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:22:16 INFO - PROCESS | 1415 | RSS: Main: 213823488 17:22:16 INFO - PROCESS | 1415 | 17:22:18 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:22:19 INFO - PROCESS | 1415 | RSS: Main: 218091520 17:22:19 INFO - PROCESS | 1415 | 17:22:21 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:22 INFO - PROCESS | 1415 | RSS: Main: 225181696 17:22:22 INFO - PROCESS | 1415 | 17:22:25 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:22:25 INFO - PROCESS | 1415 | RSS: Main: 227176448 17:22:25 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | Cycle 1(1): loaded http://localhost:47151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47151/tests/kraken/driver.html?testName=ai-astar) 17:22:27 INFO - PROCESS | 1415 | RSS: Main: 269688832 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | __start_tp_report 17:22:27 INFO - PROCESS | 1415 | _x_x_mozilla_page_load 17:22:27 INFO - PROCESS | 1415 | _x_x_mozilla_page_load_details 17:22:27 INFO - PROCESS | 1415 | |i|pagename|runs| 17:22:27 INFO - PROCESS | 1415 | |0;ai-astar;111;106;111;111;117;111;112;109;110;111 17:22:27 INFO - PROCESS | 1415 | |1;audio-beat-detection;154;131;130;189;133;128;160;126;165;132 17:22:27 INFO - PROCESS | 1415 | |2;audio-dft;161;160;164;162;163;163;161;162;160;161 17:22:27 INFO - PROCESS | 1415 | |3;audio-fft;74;74;76;124;74;75;75;74;110;75 17:22:27 INFO - PROCESS | 1415 | |4;audio-oscillator;85;85;116;85;85;85;119;89;84;132 17:22:27 INFO - PROCESS | 1415 | |5;imaging-gaussian-blur;117;117;117;120;117;117;118;117;117;118 17:22:27 INFO - PROCESS | 1415 | |6;imaging-darkroom;145;146;146;145;147;145;147;145;145;146 17:22:27 INFO - PROCESS | 1415 | |7;imaging-desaturate;94;95;95;95;96;96;96;96;95;95 17:22:27 INFO - PROCESS | 1415 | |8;json-parse-financial;54;52;54;54;54;55;52;58;52;54 17:22:27 INFO - PROCESS | 1415 | |9;json-stringify-tinderbox;62;63;63;63;62;63;62;62;62;63 17:22:27 INFO - PROCESS | 1415 | |10;stanford-crypto-aes;79;79;78;86;80;80;86;80;113;84 17:22:27 INFO - PROCESS | 1415 | |11;stanford-crypto-ccm;123;122;129;125;119;136;122;123;137;141 17:22:27 INFO - PROCESS | 1415 | |12;stanford-crypto-pbkdf2;157;161;159;158;160;160;165;159;162;166 17:22:27 INFO - PROCESS | 1415 | |13;stanford-crypto-sha256-iterative;62;64;67;62;63;63;62;61;65;63 17:22:27 INFO - PROCESS | 1415 | __end_tp_report 17:22:27 INFO - PROCESS | 1415 | __start_cc_report 17:22:27 INFO - PROCESS | 1415 | _x_x_mozilla_cycle_collect,1613 17:22:27 INFO - PROCESS | 1415 | __end_cc_report 17:22:27 INFO - PROCESS | 1415 | __startTimestamp1465258947735__endTimestamp 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | ------- Summary: start ------- 17:22:27 INFO - PROCESS | 1415 | Number of tests: 14 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.73 (2.5%) stddev-sans-first:2.89 17:22:27 INFO - PROCESS | 1415 | Values: 111.0 106.0 111.0 111.0 117.0 111.0 112.0 109.0 110.0 111.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:143.50 stddev:21.15 (14.7%) stddev-sans-first:22.17 17:22:27 INFO - PROCESS | 1415 | Values: 154.0 131.0 130.0 189.0 133.0 128.0 160.0 126.0 165.0 132.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 17:22:27 INFO - PROCESS | 1415 | Values: 161.0 160.0 164.0 162.0 163.0 163.0 161.0 162.0 160.0 161.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#3] audio-fft Cycles:10 Average:83.10 Median:74.50 stddev:18.18 (24.4%) stddev-sans-first:18.98 17:22:27 INFO - PROCESS | 1415 | Values: 74.0 74.0 76.0 124.0 74.0 75.0 75.0 74.0 110.0 75.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:18.32 (21.6%) stddev-sans-first:18.95 17:22:27 INFO - PROCESS | 1415 | Values: 85.0 85.0 116.0 85.0 85.0 85.0 119.0 89.0 84.0 132.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 17:22:27 INFO - PROCESS | 1415 | Values: 117.0 117.0 117.0 120.0 117.0 117.0 118.0 117.0 117.0 118.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 17:22:27 INFO - PROCESS | 1415 | Values: 145.0 146.0 146.0 145.0 147.0 145.0 147.0 145.0 145.0 146.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 17:22:27 INFO - PROCESS | 1415 | Values: 94.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.79 (3.3%) stddev-sans-first:1.90 17:22:27 INFO - PROCESS | 1415 | Values: 54.0 52.0 54.0 54.0 54.0 55.0 52.0 58.0 52.0 54.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 17:22:27 INFO - PROCESS | 1415 | Values: 62.0 63.0 63.0 63.0 62.0 63.0 62.0 62.0 62.0 63.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:80.00 stddev:10.44 (13.0%) stddev-sans-first:10.88 17:22:27 INFO - PROCESS | 1415 | Values: 79.0 79.0 78.0 86.0 80.0 80.0 86.0 80.0 113.0 84.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.00 stddev:7.65 (6.0%) stddev-sans-first:7.92 17:22:27 INFO - PROCESS | 1415 | Values: 123.0 122.0 129.0 125.0 119.0 136.0 122.0 123.0 137.0 141.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:160.50 stddev:2.91 (1.8%) stddev-sans-first:2.76 17:22:27 INFO - PROCESS | 1415 | Values: 157.0 161.0 159.0 158.0 160.0 160.0 165.0 159.0 162.0 166.0 17:22:27 INFO - PROCESS | 1415 | 17:22:27 INFO - PROCESS | 1415 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.75 (2.8%) stddev-sans-first:1.80 17:22:27 INFO - PROCESS | 1415 | Values: 62.0 64.0 67.0 62.0 63.0 63.0 62.0 61.0 65.0 63.0 17:22:27 INFO - PROCESS | 1415 | -------- Summary: end -------- 17:22:27 INFO - PROCESS | 1415 | 17:22:28 INFO - TEST-INFO | 1415: exit 0 17:22:28 INFO - TEST-OK | kraken | took 61570ms 17:22:28 INFO - SUITE-END | took 1175s 17:22:28 INFO - Completed test suite (00:19:36) 17:22:28 INFO - javascript benchmark 17:22:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.2504198992237, 3131.9686803131963, 3156.7632427567937, 3175.634801997771, 3191.2341038150853, 5287.603429742765, 5313.814016509423, 5362.490563396481, 5419.051665958451, 5431.402545719972, 5362.383325917511, 5404.729763511828, 5439.700816455093, 5561.054620714478, 5572.275604171452, 4794.400699912502, 4830.227163653816, 4844.442889067767, 4925.605951523888, 4957.702537847741, 4995.725235112068, 5018.172001619747, 5045.217991211368, 5053.77258023388, 5085.389753229599, 4788.688735232199, 4825.517448255181, 4965.37932758407, 4969.975150124263, 5003.349564556603, 4868.099401610678, 4902.289168070645, 4917.065757506062, 4935.457099719028, 5011.599072074226, 4912.754362281908, 4913.361263035818, 4918.065567542156, 4926.0, 4928.236123400879, 5357.598180136505, 5396.10964190908, 5415.458454154593, 5423.430539793344, 5426.240326354314, 5639.605227634067, 5725.856853578653, 5800.622959507618, 5804.506616937565, 5804.651720896717, 5915.053591425351, 5919.437653422918, 5920.111983202511, 5928.911066334009, 5932.851678708023, 5277.0, 5476.644018138808, 5517.227588137664, 5521.337439507285, 5524.475174858382, 5809.564282678816, 5851.180834683148, 5881.588288819741, 5943.673097979653, 6002.699865006733, 5699.658020518699, 5743.0, 5746.195532625436, 5749.482546570829, 5775.220345253337, 5604.0, 5801.6519008859605, 5808.535317174616, 5857.824265272048, 5858.5898987070495, 5652.180433837153, 5720.713964301768, 5722.141678748221, 5738.913916291259, 5749.367569567345, 5770.624909380961, 5790.739416726257, 5793.188953546507, 5794.88410231793, 5797.188393624896, 4323.0705398339505, 4342.934855977162, 4343.19650864591, 4353.998580326479, 4388.166248412791, 3931.0565464288366, 3936.822842972073, 3941.507311586052, 3972.7219094663674, 3989.880303590897, 5413.864653383618, 5414.29614150158, 5422.539084177889, 5430.456954304538, 5483.2049352844415, 5580.218769372291, 5729.48434640876, 5813.069908814569, 5844.9415505845245, 5860.09168578871, 5468.207109969032, 5469.316335458067, 5487.204355368449, 5499.835004949778, 5516.172574113915, 4864.78108485119, 4979.30289759434, 4987.650864439527, 4993.550580447704, 5034.295198672189, 5805.477507024304, 5883.676397798162, 5986.2517185351835, 5989.55078369124, 5992.820215393545, 5732.914006289992, 5857.121431785266, 5870.911936321044, 5876.6180198288685, 5917.467427931335, 5910.645361278337, 5939.881202376015, 5946.43508866657, 5959.255093113361, 5971.4327138921735, 5544.667319960815, 5686.800961966312, 5726.284214473191, 5731.8853622928145, 5741.598088133791, 5923.526117910643, 5952.821415357546, 5964.224650795369, 5969.283685957713, 5995.850103747442, 5791.0734282514595, 5796.82609521715, 5800.24596802413, 5802.912956305574, 5806.071028635398, 5463.399026107205, 5536.4186760389575, 5575.080111781511, 5646.209530665628, 5721.656700597978, 5583.385827559046, 5584.190292407659, 5587.832365029056, 5589.552835773047, 5592.748326325243, 5736.5984381094595, 5752.194692743103, 5792.855178620568, 5796.971015145066, 5797.9420205797405, 5401.648892821954, 5440.591955603267, 5453.945460545344, 5477.4248703887115, 5493.807716729895], "value": 5342.294748234059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8150991682661, 623.155624129305, 623.17429406037, 633.3223450907531, 634.6255709131613, 31209.843950780243, 44316.0, 45295.54704452954, 45335.0, 45362.54637453624, 45760.084798304015, 46265.30602040972, 46302.0, 46336.0, 46352.76823615877, 8046.235607617267, 8261.215184557488, 8270.0, 8708.95645521773, 8907.198352148305, 8173.591320433984, 10273.407621818593, 10634.78730425391, 10658.946705266462, 11044.061254793352, 10825.729356766104, 10893.618723344685, 10901.345919244832, 10905.18211134164, 10908.563657453731, 8070.919290807075, 8319.168083191693, 10667.413292268922, 10788.460576971198, 10795.892041079607, 8301.792455188608, 10039.34744241622, 10470.47647617616, 10475.161987041018, 10748.838767418494, 42758.0, 43125.56874431247, 43140.0, 43251.13497730059, 43302.35046474305, 3150.401423729484, 3178.698023687746, 3350.6816852398983, 3510.1224693826543, 3612.801295928723, 31981.840090799396, 32750.672493275, 32859.0, 33202.16994575131, 33489.330213395595, 4269.466316710411, 4328.870133895988, 4332.71593873855, 4348.4999225089205, 4525.208088584484, 356491.0, 357079.0, 357243.0, 357857.0, 358283.0, 58730.412695872496, 58966.41033589609, 59223.0, 59343.40656593379, 59343.40656593379, 35578.37481127437, 36586.451203231976, 36828.07929801723, 38730.80634596809, 38793.67237965731, 17242.913785430992, 17347.479575612753, 17388.82611173872, 17421.390251341396, 17422.738658920127, 12220.205686630341, 13042.934785326202, 13307.66730831737, 13426.530071447452, 13457.663558411117, 19589.804101959082, 19781.20875165006, 19797.20811167566, 19876.50308742293, 19888.10503527345, 6829.419499342612, 6840.452763778985, 6933.237343892168, 6951.3396227359335, 7091.0, 1005.4922264256504, 1048.292402628238, 1094.6497120921388, 1136.3409222650844, 1191.362620997762, 33044.1738956528, 33074.83462582672, 33176.0, 33237.833810830794, 33999.0, 1084.6312253833735, 1125.1729978465821, 1125.6285425809463, 1140.1904647700226, 1209.2079687804503, 17046.147692615566, 17589.20848561818, 17640.0, 17646.647067058588, 17739.733903991193, 591565.0, 593997.0, 594133.0, 597730.0, 600708.0, 59230.70384648135, 60571.39428605745, 60745.0, 60808.695956519936, 60828.69585652043, 1279.5649479177125, 1370.0615078671142, 1394.7977543256375, 1400.3978289335682, 1411.3155119766905, 32146.0, 34337.14157145991, 34367.0, 34623.0, 34816.0, 51249.74375128101, 51503.484965149866, 51891.481085188665, 51899.0, 51912.74043629758, 428266.0, 429928.0, 430347.0, 431103.0, 431423.0, 25059.248222553353, 27045.188644340702, 28145.296367590974, 28299.0, 29909.102726918227, 48114.0, 48921.75539122282, 49043.50956490532, 49983.25025124553, 50078.0, 41255.7937210312, 41480.1703965913, 41675.7916210417, 42590.0, 42624.14751705011, 40876.79561602173, 41111.7944410276, 41424.58575414207, 42101.78949105235, 42269.0, 41264.1747165061, 41951.58048419477, 42238.0, 42545.78727106345, 42713.359299611155, 35928.82035589805, 37059.7733441987, 37194.25611487701, 37792.244155117296, 37864.43203351897, 28078.85960570184, 28210.0, 28426.715732842407, 28553.0, 28681.0], "value": 20480.278062385896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.18021924287876, 394.74933417280016, 395.48389351895776, 401.4399912122589, 419.75444365046445, 17863.285468581256, 19001.809981900176, 19403.708944365844, 19411.12649930753, 19421.22315107394, 17455.73816392752, 18644.627107457844, 18849.151788169533, 19805.405837824852, 19806.504837379038, 5675.829725108243, 5784.045632470637, 5818.854528636797, 5829.213056237418, 5874.324452687932, 5669.376368599451, 5760.596758226926, 5781.075027995522, 5790.507806836424, 5802.100674395476, 5670.546356291507, 5736.426357364272, 5783.797567085153, 5805.709714514257, 5817.796377126801, 5706.600537962344, 5737.799177028825, 5780.1907732917425, 5788.47903688668, 5823.708814559276, 4913.680610760289, 5230.189320655304, 5234.241035049897, 5284.815031473919, 5294.205869119624, 21393.893030534902, 21596.244131455325, 21738.0, 21757.694538327592, 21857.0, 2159.91360345586, 2173.913043478259, 2181.4982554012668, 2231.4086767006756, 2773.833569985807, 9486.525673716356, 9574.617015319378, 9870.654527091589, 9929.156021738161, 10124.392536447836, 1696.9236384362732, 1799.073477159264, 1806.4309742431092, 1867.7385166076624, 1916.4633902507321, 80801.59599202026, 83006.16993830045, 83110.58444707798, 85228.14771852264, 87820.0, 10365.689029329133, 10418.426986515662, 10522.368657880552, 10622.309549879234, 10651.082805095157, 14970.0, 14994.925025374803, 15010.849891501164, 15069.17119558413, 15204.239788010776, 7753.8449231015065, 8094.716684915999, 8161.306288965386, 8340.41617086798, 8344.998600168019, 7856.646450909723, 7886.684532618746, 7901.762947111596, 8094.635741391651, 8152.959235203786, 4466.39703640011, 4551.817927282872, 4608.585227329557, 4657.74382408964, 4744.95255047452, 1932.951676208106, 1943.9028048597513, 1956.4717526267827, 1965.3809050149157, 1979.4465139969566, 900.320258205051, 965.285688590438, 1008.969730908074, 1018.3686114608989, 1026.1431704526653, 18503.35238266654, 18658.720119198224, 18873.150708218163, 18896.811031889505, 19435.22259109648, 947.0387556630026, 947.9478628675352, 954.4082668745283, 983.041534503853, 993.0516356879308, 10337.586496540205, 10619.575216991389, 10699.518521666543, 10719.088877445505, 10741.516631751434, 504920.0, 508565.28384170716, 513189.0, 518221.0, 520082.0, 92179.0, 92193.0, 92748.0, 93191.53404232935, 94346.52826735823, 963.330485312701, 973.4159504297365, 991.3258983890879, 991.5290237137447, 993.5082134343546, 16400.917995409945, 16696.749548757023, 16985.32058717687, 17033.82966170372, 17306.740398893773, 38715.80642096772, 39480.0, 40423.0, 41195.58804411918, 43421.131577368906, 56214.718926405105, 57352.42647573471, 58618.0, 58739.4126058734, 59424.40575594362, 8414.747557573282, 8720.91279087201, 8764.430312029697, 8772.649094036422, 8829.514376709343, 9943.801123977335, 13400.865991340352, 13623.38694758758, 13676.52132175409, 13822.723545529234, 11128.888711112786, 11480.770384592428, 11573.0, 11634.011109055487, 11881.1089168311, 11746.823797642872, 11830.994365478686, 11842.0, 12178.939105304416, 12225.388730563614, 10801.082785495646, 11622.0, 11740.0, 11774.94112529432, 11863.0, 8438.493690378597, 8694.521801300736, 8734.868976965477, 8739.519326436852, 8808.20726134651, 8767.517786521548, 11188.776224475629, 11529.135314851252, 11917.0, 11996.220245684002], "value": 9113.451398543612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.1791676451917, 1471.8307394649614, 1488.0327786938492, 1656.9502914912557, 1826.6164105537844, 8154.225348591882, 8567.871481927768, 8571.528565928878, 8811.559422028906, 8813.4711917285, 8534.74395768128, 8718.782030449242, 8733.519656418894, 8737.38838281319, 8739.606717697703, 2090.163934426234, 2291.679164916913, 2317.640765681318, 2364.7517010713887, 2376.2396033269274, 2396.9041238350446, 2404.1345115758313, 2415.335782659765, 2416.565018296706, 2420.5279970405777, 2340.9531809363802, 2359.6224604063354, 2410.819188560865, 2411.360989337827, 2417.033186725306, 2027.7972202779752, 2190.6494960806353, 2264.1509433962265, 2266.172846910882, 2296.781805728453, 2347.1315613223046, 2351.0595761695286, 2372.632242002492, 2380.8571485710913, 2383.833131680783, 8717.825643487158, 8771.956140219258, 8790.384673072887, 8797.516136612483, 8800.735977920673, 5223.817166399196, 5343.786248550054, 5368.275282836806, 5372.086745253317, 5376.838694839161, 3321.7674762766615, 3406.131436483706, 3495.4931534927546, 3507.8947631571095, 3533.116720819795, 1209.866914639389, 1249.3066348176758, 1250.1374051904156, 1259.1563652352945, 1274.0953922714884, 12205.93897030518, 12250.44872980709, 12269.693257668541, 12282.508699652004, 12303.630891073193, 4652.043645687153, 4803.519648035169, 4817.494163112893, 4827.927581086216, 4885.5358740919555, 10181.643642472625, 10236.283460157867, 10236.53935572901, 10240.0, 10240.334378265537, 5364.927014597019, 5407.783688652488, 5415.620906536584, 5416.295881535454, 5419.105847535113, 4340.457442819647, 4807.134715751128, 4959.900801984012, 4968.080905032581, 5027.698338099725, 3884.0, 4020.7386519876113, 4036.4348991141264, 4090.7341022834016, 4117.258893399157, 1270.7712611729792, 1282.4741855839247, 1283.6020833541445, 1294.976968195134, 1306.301128896036, 980.1962390839585, 980.9166220871306, 995.8655581496405, 1000.4697510319543, 1005.8491226316111, 5877.177195192677, 5892.823215303548, 5940.376260492672, 5961.940380596138, 6037.607555508966, 472.822691490691, 475.5102244687977, 486.0667518364748, 486.8101440438232, 490.01506970987856, 4014.6988975826343, 4077.4699289092227, 4085.8569950051606, 4087.325591277406, 4187.832486700559, 10378.976099660495, 10886.67339979786, 10892.564297428014, 10915.0, 10942.069924056384, 10324.0, 10846.511906964206, 10874.18443616732, 10884.455777211107, 10886.891131088747, 7983.560904150328, 8274.586270686441, 8308.626111824982, 8345.207205315606, 8346.332293416512, 5990.88018239624, 6258.780942666985, 6258.874822503433, 6283.874322513433, 6340.784769351234, 9959.352642078242, 10216.080552750289, 10255.435951022766, 10267.435291059064, 10382.117520010883, 10278.229132814919, 10288.485575721033, 10377.896221037692, 10393.53229104677, 10399.064084232456, 7162.283771622796, 7317.0487836580905, 7322.926770732224, 7641.45034449149, 7872.72445464406, 8151.714689985822, 8232.83534329322, 8482.448640838325, 8501.95749021251, 8753.956230218808, 7383.667734951832, 7383.8154046149275, 7522.6614802335125, 7721.305082542598, 7843.960780196063, 7463.0, 7590.962045189739, 7658.119316278699, 7758.0, 7779.57212353326, 6753.662316884234, 6784.118064651564, 6814.557053791686, 6815.556988795911, 6818.0, 5061.39263288393, 5100.642954993264, 5219.373675159005, 5279.26090347344, 5281.55106815925, 5293.2589437479555, 5370.731463426891, 5390.892182156256, 5399.568034557305, 5442.6462279951675], "value": 4588.694444139838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.770671996003, 317.0583367398825, 317.56493603762834, 319.0985466058386, 324.14102628035704, 5385.219143224235, 5396.109641909085, 5421.403645598986, 5426.131818908975, 5431.049566325897, 5304.867378315535, 5333.38666053404, 5383.0, 5418.972905135469, 5424.9186262206, 3986.421968814527, 4097.078157414588, 4107.856225032125, 4164.479440069991, 4223.894402639928, 4169.895752606179, 4182.498100227962, 4200.537940826506, 4208.347706105558, 4214.957850421502, 4125.23683118624, 4145.782006626456, 4147.6474499667565, 4175.311073672856, 4176.206520761046, 3996.260691772017, 3998.280309544281, 4163.5836416358125, 4169.395437661552, 4199.874003779892, 3650.105724097613, 3662.432322989941, 3675.0, 3680.411134218539, 3703.0, 5168.8966220675375, 5202.843914682566, 5204.739763011872, 5219.582433405319, 5270.420253772082, 4543.636509079266, 4732.881677958044, 4736.123817093849, 4745.857624271277, 4756.762161891892, 5589.189567512688, 5641.492265696107, 5654.264945557051, 5674.404187560288, 5728.255326807488, 3822.2928758179546, 3907.765534067965, 3980.7014473914574, 3992.261431635157, 4021.4973128358956, 5814.97092514539, 5856.540253093668, 5875.73671660595, 5885.264341957255, 5915.940840591625, 4068.247374235776, 4072.75563466193, 4099.139180772071, 4108.650764685035, 4128.958710412858, 4086.5504794472586, 4114.485689288839, 4159.982408531921, 4187.45563076798, 4199.4330765346895, 4706.458757242893, 4735.95264047362, 4749.503906269514, 4785.617150627942, 4818.7831547580445, 5688.203651488712, 5691.971540142273, 5695.971520142456, 5702.600817942787, 5725.8568535786935, 1381.1989046353092, 1387.2300873015372, 1388.2966591632432, 1400.8178936738364, 1408.746425643394, 888.5646033443566, 902.8194361127801, 903.9954800225956, 910.6038873090095, 999.5601935148657, 5409.67305107364, 5413.810516631899, 5419.458054194549, 5433.1850222466155, 5441.156620723794, 5725.53801865202, 5774.220480235199, 5784.929787989236, 5813.767449302065, 5836.737346819404, 5233.162693968947, 5440.755166017539, 5497.835064948058, 5557.332800159936, 5563.190588752654, 3110.9688903110678, 3127.2799960022353, 3135.325904930451, 3165.572647692578, 3173.444647186733, 5746.885062298814, 6116.908246376308, 6142.907856382158, 6144.78493252734, 6168.0, 6004.639721616717, 6029.0, 6051.394860513913, 6094.35452427842, 6102.511799056065, 6019.819405417757, 6022.969885150546, 6064.75740970365, 6155.692215389213, 6167.660778657217, 5601.551875850004, 5894.2926848778425, 5911.497522710446, 5931.377205393372, 5942.73257703413, 5814.592978491465, 5823.418597562384, 5841.737121829443, 5861.85693789724, 5877.853053673522, 5791.884162316815, 6069.969650151721, 6084.361142080195, 6104.664243466652, 6105.0, 4140.8136633850945, 4173.311403618369, 4182.64447521964, 4183.740779978899, 4196.1607678463815, 5939.455741507153, 5964.940350596438, 5978.701064946822, 6007.879842403215, 6009.2188015557695, 5678.403767604507, 5702.232307984538, 5704.914426283692, 5757.510611598061, 5840.445157710011, 5699.715014249354, 5729.28383952006, 5760.164776107525, 5761.905238004766, 5789.2184555086205, 5175.0, 5431.6740995540395, 5673.978683836784, 5696.060150075191, 5702.429757024264, 5774.220480235283, 5777.3933736957015, 5800.216970708901, 5808.477237048517, 5808.634970781778, 5615.719214039364, 5644.181593668977, 5672.60291779588, 5679.290088738908, 5681.261436013458], "value": 4311.9773517037365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.9304666056722, 766.5592284436447, 789.3409003482092, 813.1096449387918, 846.1158089796162, 13381.799273010913, 15277.618059548517, 15394.307256173472, 15445.22773861308, 15464.381424742996, 14750.852491475109, 14783.482578109768, 14885.479008234714, 14919.850801491983, 14952.925235373836, 655.4919937048778, 660.4683229999848, 772.7334069745929, 772.8145245141181, 802.297989259398, 800.8198155415043, 806.9072056713494, 808.3533173461237, 810.9189081091903, 811.7199566149669, 687.7524091327118, 847.0174597466939, 847.5126802088793, 847.5253857839599, 847.995760021199, 803.8392321535687, 831.2145022953312, 831.8170002599419, 833.7207035643066, 835.2649668291864, 605.7153138025121, 605.7243954000963, 607.0408754168403, 607.1954660075418, 607.3713706313988, 12897.0, 12901.0, 12925.418356173996, 12964.351782410842, 12968.416421261067, 14117.364718587585, 14159.292035398188, 14400.927995360062, 14800.925995369955, 14960.775588366183, 11024.779504409948, 11332.320060796379, 11741.29552226869, 12529.248245105322, 12624.74750504994, 4560.384348112995, 4618.815247390134, 4619.953800461986, 4645.976770116162, 4673.275642275453, 79121.0, 80749.19250807534, 80930.59534702289, 81204.59397703032, 82043.0, 9712.660056897974, 9843.704688859345, 10119.291649584458, 10399.272050956512, 10532.262741608167, 20525.17899284012, 20592.0, 20674.379768606967, 20844.58310833775, 20898.477538061365, 8367.62345694433, 8540.274076703425, 8724.912750872538, 8725.476471411735, 8932.776680582907, 4445.310976798602, 4461.955380446219, 4576.679632425698, 4678.0, 4860.489648586848, 3460.3598334308235, 3656.1956369598647, 3663.212409331953, 3665.4685070664605, 3671.632836716307, 619.2043224456552, 619.5941658213877, 650.7917466410797, 651.4104735214638, 684.1448189762797, 649.3023716884377, 704.7216349542005, 707.3527722134293, 721.8267615772177, 724.8402555910501, 9497.0, 10813.351198928089, 10852.131829453625, 10859.728506787393, 10954.452277386099, 650.7279708712289, 715.2132654080469, 717.5228473065457, 749.9137599176164, 759.1421693486325, 4760.571548560646, 4905.7301848397965, 5119.232115182678, 5135.974320128375, 5199.324087868553, 78539.0, 78866.6056669713, 119244.0, 121028.0, 129205.35397322953, 85767.5711621438, 109982.45008775065, 110255.0, 110298.44850775856, 110873.44563277133, 53108.468915311125, 54425.0, 60282.0, 87378.56310718406, 87618.56190718878, 9651.855222171533, 9652.517374131125, 9669.661561845302, 9682.042939825733, 9706.126448619658, 43773.0, 48862.75568622134, 49299.0, 50085.24872126848, 50316.24525632045, 65582.67208663926, 65719.0, 75422.6228868874, 76401.0, 77371.2262877364, 13024.609261722164, 13095.41070651842, 13308.667283317995, 13319.400626971616, 13572.79640805369, 15044.774328384865, 15152.242387880342, 15342.846571534588, 15517.922410387875, 15704.764428533352, 13165.078444508792, 13251.933740331237, 13304.733905322033, 13499.190048597116, 13704.65738356549, 14334.283285835458, 14363.425462981364, 14607.342669579682, 14642.0, 15108.244587770349, 14075.155490670593, 14094.0, 14427.711445771236, 14918.104913705212, 14937.925310373379, 10182.847257290998, 10235.948820255851, 10249.586348503783, 10404.32989484853, 10691.625793097204, 10571.735706607089, 10627.09669678086, 11070.778584428106, 11311.717207069889, 11353.602623908124], "value": 7498.824476195652, "unit": "score"}], "name": "dromaeo_css", "value": 7272.63429207543, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 117.0, 111.0, 112.0, 109.0, 110.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 130.0, 189.0, 133.0, 128.0, 160.0, 126.0, 165.0, 132.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 164.0, 162.0, 163.0, 163.0, 161.0, 162.0, 160.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 124.0, 74.0, 75.0, 75.0, 74.0, 110.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 85.0, 85.0, 85.0, 119.0, 89.0, 84.0, 132.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 120.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 147.0, 145.0, 147.0, 145.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 54.0, 54.0, 55.0, 52.0, 58.0, 52.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 86.0, 80.0, 80.0, 86.0, 80.0, 113.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 129.0, 125.0, 119.0, 136.0, 122.0, 123.0, 137.0, 141.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 159.0, 158.0, 160.0, 160.0, 165.0, 159.0, 162.0, 166.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 67.0, 62.0, 63.0, 63.0, 62.0, 61.0, 65.0, 63.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1508.0000000000002, "alertThreshold": 2.0}]} 17:22:28 INFO - Return code: 0 17:22:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:22:29 ERROR - # TBPL SUCCESS # 17:22:29 INFO - Running post-action listener: _resource_record_post_action 17:22:29 INFO - ##### 17:22:29 INFO - ##### Finished run-tests step (success) 17:22:29 INFO - ##### 17:22:29 INFO - Running post-run listener: _resource_record_post_run 17:22:29 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 550006784; Read time: 0; Write time: 1556988 17:22:29 INFO - TinderboxPrint: CPU usage
13.2% 17:22:29 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:22:29 INFO - TinderboxPrint: I/O write bytes / time
550,006,784 / 1,556,988 17:22:29 INFO - TinderboxPrint: CPU idle
8,273.7 (86.7%) 17:22:29 INFO - TinderboxPrint: CPU user
1,207.7 (12.7%) 17:22:29 INFO - TinderboxPrint: Swap in / out
0 / 0 17:22:29 INFO - install - Wall time: 18s; CPU: 19.0%; Read bytes: 0; Write bytes: 261955584; Read time: 0; Write time: 1050840 17:22:29 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288051200; Read time: 0; Write time: 506148 17:22:29 INFO - Running post-run listener: _upload_blobber_files 17:22:29 INFO - Blob upload gear active. 17:22:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:22:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:22:30 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:33 INFO - (blobuploader) - INFO - Done attempting. 17:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:34 INFO - (blobuploader) - INFO - Done attempting. 17:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:35 INFO - (blobuploader) - INFO - Done attempting. 17:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:35 INFO - Return code: 0 17:22:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44a877d346ed1d9be325024dc8825900357fd3e387b071933f9996d5e7ac259855443b03d89ab149b7b1017bdd8935f54047b9e05dc6b910471a566bcac5052c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1341e5e487de9c50023279914d78a36dd4836a058cd5ec0d02f4754f545525a116e6f00d2fe4177103641a01f98f7cf1d3edda6a6860032b9a31811a97c2b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71ac4686c2142a25539a2b46253cb93ad6c2ed16cf56b27c14f05d3df1b94b2a2c04f4c3801981e5325b097a82dd6e7ed6e0a8e421e9b88cea7de4287fc58630"} 17:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:35 INFO - Contents: 17:22:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44a877d346ed1d9be325024dc8825900357fd3e387b071933f9996d5e7ac259855443b03d89ab149b7b1017bdd8935f54047b9e05dc6b910471a566bcac5052c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1341e5e487de9c50023279914d78a36dd4836a058cd5ec0d02f4754f545525a116e6f00d2fe4177103641a01f98f7cf1d3edda6a6860032b9a31811a97c2b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71ac4686c2142a25539a2b46253cb93ad6c2ed16cf56b27c14f05d3df1b94b2a2c04f4c3801981e5325b097a82dd6e7ed6e0a8e421e9b88cea7de4287fc58630"} 17:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:35 INFO - Copying logs to upload dir... 17:22:35 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.850536 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-06 17:22:35.327061) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 17:22:35.330895) ========= 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=df17445c3590ff7897617a0e00000225-1465257716.755680-558871115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44a877d346ed1d9be325024dc8825900357fd3e387b071933f9996d5e7ac259855443b03d89ab149b7b1017bdd8935f54047b9e05dc6b910471a566bcac5052c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1341e5e487de9c50023279914d78a36dd4836a058cd5ec0d02f4754f545525a116e6f00d2fe4177103641a01f98f7cf1d3edda6a6860032b9a31811a97c2b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71ac4686c2142a25539a2b46253cb93ad6c2ed16cf56b27c14f05d3df1b94b2a2c04f4c3801981e5325b097a82dd6e7ed6e0a8e421e9b88cea7de4287fc58630"} 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.011468 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44a877d346ed1d9be325024dc8825900357fd3e387b071933f9996d5e7ac259855443b03d89ab149b7b1017bdd8935f54047b9e05dc6b910471a566bcac5052c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1341e5e487de9c50023279914d78a36dd4836a058cd5ec0d02f4754f545525a116e6f00d2fe4177103641a01f98f7cf1d3edda6a6860032b9a31811a97c2b03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71ac4686c2142a25539a2b46253cb93ad6c2ed16cf56b27c14f05d3df1b94b2a2c04f4c3801981e5325b097a82dd6e7ed6e0a8e421e9b88cea7de4287fc58630"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 17:22:35.356048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:22:35.356341) ========= 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=df17445c3590ff7897617a0e00000225-1465257716.755680-558871115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 17:22:35.439974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 17:22:35.440257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 17:22:35.440544) ========= ========= Total master_lag: 0.17 =========