builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1465295190.81 results: success (0) buildid: 20160607004038 builduid: 8af13598d81e431d86097476eb8887d1 revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:30.812496) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:30.812991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:30.813305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:30.828566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:30.828897) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 03:26:30-- 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% 37.4M=0s 2016-06-07 03:26:31 (37.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129686 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:30.974689) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:30.975233) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016926 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:31.026218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 03:26:31.026615) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e70892847544db94d801f80543fe8a7f6d836f90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e70892847544db94d801f80543fe8a7f6d836f90 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 03:26:31,138 truncating revision to first 12 chars 2016-06-07 03:26:31,138 Setting DEBUG logging. 2016-06-07 03:26:31,138 attempt 1/10 2016-06-07 03:26:31,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e70892847544?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 03:26:32,377 unpacking tar archive at: mozilla-aurora-e70892847544/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571100 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 03:26:32.612191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:32.612602) ========= script_repo_revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:32.613021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:32.613326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 03:26:32.622728) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-07 03:26:32.623070) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:32 INFO - MultiFileLogger online at 20160607 03:26:32 in /builds/slave/test 03:26:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:26:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:32 INFO - {'append_to_log': False, 03:26:32 INFO - 'base_work_dir': '/builds/slave/test', 03:26:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:26:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:32 INFO - 'branch': 'Mozilla-Aurora', 03:26:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:32 INFO - 'config_files': ('talos/linux_config.py',), 03:26:32 INFO - 'default_actions': ('clobber', 03:26:32 INFO - 'read-buildbot-config', 03:26:32 INFO - 'download-and-extract', 03:26:32 INFO - 'populate-webroot', 03:26:32 INFO - 'create-virtualenv', 03:26:32 INFO - 'install', 03:26:32 INFO - 'run-tests'), 03:26:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:32 INFO - 'download_minidump_stackwalk': True, 03:26:32 INFO - 'download_symbols': 'ondemand', 03:26:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:32 INFO - 'installer_path': 'installer.exe', 03:26:32 INFO - 'log_level': 'info', 03:26:32 INFO - 'log_name': 'talos', 03:26:32 INFO - 'log_to_console': True, 03:26:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:32 INFO - 'opt_config_files': (), 03:26:32 INFO - 'pip_index': False, 03:26:32 INFO - 'sps_profile': False, 03:26:32 INFO - 'sps_profile_interval': 0, 03:26:32 INFO - 'suite': 'dromaeojs-e10s', 03:26:32 INFO - 'system_bits': '32', 03:26:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:32 INFO - 'title': 'talos-linux64-ix-036', 03:26:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:32 INFO - 'use_talos_json': True, 03:26:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:32 INFO - 'work_dir': 'build'} 03:26:32 INFO - ##### 03:26:32 INFO - ##### Running clobber step. 03:26:32 INFO - ##### 03:26:32 INFO - Running pre-action listener: _resource_record_pre_action 03:26:32 INFO - Running main action method: clobber 03:26:32 INFO - rmtree: /builds/slave/test/build 03:26:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:33 INFO - Running post-action listener: _resource_record_post_action 03:26:33 INFO - ##### 03:26:33 INFO - ##### Finished clobber step (success) 03:26:33 INFO - ##### 03:26:33 INFO - ##### 03:26:33 INFO - ##### Running read-buildbot-config step. 03:26:33 INFO - ##### 03:26:33 INFO - Running pre-action listener: _resource_record_pre_action 03:26:33 INFO - Running main action method: read_buildbot_config 03:26:33 INFO - Using buildbot properties: 03:26:33 INFO - { 03:26:33 INFO - "project": "", 03:26:33 INFO - "product": "firefox", 03:26:33 INFO - "script_repo_revision": "production", 03:26:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:26:33 INFO - "repository": "", 03:26:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:26:33 INFO - "buildid": "20160607004038", 03:26:33 INFO - "stage_platform": "linux64-pgo", 03:26:33 INFO - "basedir": "/builds/slave/test", 03:26:33 INFO - "nightly_build": "True", 03:26:33 INFO - "buildnumber": 342, 03:26:33 INFO - "slavename": "talos-linux64-ix-036", 03:26:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:26:33 INFO - "platform": "ubuntu64_hw", 03:26:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:26:33 INFO - "branch": "mozilla-aurora", 03:26:33 INFO - "repo_path": "releases/mozilla-aurora", 03:26:33 INFO - "revision": "e70892847544db94d801f80543fe8a7f6d836f90", 03:26:33 INFO - "pgo_build": "True", 03:26:33 INFO - "builduid": "8af13598d81e431d86097476eb8887d1", 03:26:33 INFO - "slavebuilddir": "test" 03:26:33 INFO - } 03:26:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:26:33 INFO - Running post-action listener: _resource_record_post_action 03:26:33 INFO - ##### 03:26:33 INFO - ##### Finished read-buildbot-config step (success) 03:26:33 INFO - ##### 03:26:33 INFO - ##### 03:26:33 INFO - ##### Running download-and-extract step. 03:26:33 INFO - ##### 03:26:33 INFO - Running pre-action listener: _resource_record_pre_action 03:26:33 INFO - Running main action method: download_and_extract 03:26:33 INFO - mkdir: /builds/slave/test/build/tests 03:26:33 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')]} 03:26:33 INFO - https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:26:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:26:34 INFO - Downloaded 1361 bytes. 03:26:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:26:34 INFO - Using the following test package requirements: 03:26:34 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:34 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:26:34 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:26:34 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'jsshell-linux-x86_64.zip'], 03:26:34 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:26:34 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:26:34 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:26:34 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:26:34 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:26:34 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:26:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:26:34 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:26:34 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')]} 03:26:34 INFO - https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:26:35 INFO - Downloaded 24472778 bytes. 03:26:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:26:37 INFO - Return code: 0 03:26:37 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:26:37 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')]} 03:26:37 INFO - https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:26:39 INFO - Downloaded 24472778 bytes. 03:26:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:26:40 INFO - Return code: 0 03:26:40 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')]} 03:26:40 INFO - https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:26:42 INFO - Downloaded 10833369 bytes. 03:26:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:26:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:26:42 INFO - Return code: 0 03:26:42 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')]} 03:26:42 INFO - https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:26:43 INFO - Downloaded 63560100 bytes. 03:26:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:43 INFO - mkdir: /builds/slave/test/properties 03:26:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:43 INFO - Contents: 03:26:43 INFO - build_url:https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:26:44 INFO - Running post-action listener: _resource_record_post_action 03:26:44 INFO - Running post-action listener: set_extra_try_arguments 03:26:44 INFO - ##### 03:26:44 INFO - ##### Finished download-and-extract step (success) 03:26:44 INFO - ##### 03:26:44 INFO - ##### 03:26:44 INFO - ##### Running populate-webroot step. 03:26:44 INFO - ##### 03:26:44 INFO - Running pre-action listener: _resource_record_pre_action 03:26:44 INFO - Running main action method: populate_webroot 03:26:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:44 INFO - '--tppagecycles', 03:26:44 INFO - '7'], 03:26:44 INFO - 'tests': ['tsvgm']}}, 03:26:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['damp', 'tps']}, 03:26:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'tests': ['damp', 'tps']}, 03:26:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['dromaeo_dom']}, 03:26:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['a11yr', 03:26:44 INFO - 'ts_paint', 03:26:44 INFO - 'tpaint', 03:26:44 INFO - 'sessionrestore', 03:26:44 INFO - 'sessionrestore_no_auto_restore', 03:26:44 INFO - 'tabpaint']}, 03:26:44 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:44 INFO - 'ts_paint', 03:26:44 INFO - 'tpaint', 03:26:44 INFO - 'sessionrestore', 03:26:44 INFO - 'sessionrestore_no_auto_restore', 03:26:44 INFO - 'tabpaint']}, 03:26:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:44 INFO - 'ts_paint', 03:26:44 INFO - 'tpaint', 03:26:44 INFO - 'sessionrestore', 03:26:44 INFO - 'sessionrestore_no_auto_restore', 03:26:44 INFO - 'tabpaint']}, 03:26:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:44 INFO - 'ts_paint', 03:26:44 INFO - 'tpaint', 03:26:44 INFO - 'sessionrestore', 03:26:44 INFO - 'sessionrestore_no_auto_restore', 03:26:44 INFO - 'tabpaint']}, 03:26:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['a11yr', 03:26:44 INFO - 'ts_paint', 03:26:44 INFO - 'tpaint', 03:26:44 INFO - 'sessionrestore', 03:26:44 INFO - 'sessionrestore_no_auto_restore', 03:26:44 INFO - 'tabpaint']}, 03:26:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['a11yr', 03:26:44 INFO - 'ts_paint', 03:26:44 INFO - 'tpaint', 03:26:44 INFO - 'sessionrestore', 03:26:44 INFO - 'sessionrestore_no_auto_restore', 03:26:44 INFO - 'tabpaint']}, 03:26:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['tsvgx', 03:26:44 INFO - 'tsvgr_opacity', 03:26:44 INFO - 'tart', 03:26:44 INFO - 'tscrollx', 03:26:44 INFO - 'cart']}, 03:26:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:44 INFO - 'tsvgr_opacity', 03:26:44 INFO - 'tart', 03:26:44 INFO - 'tscrollx', 03:26:44 INFO - 'cart']}, 03:26:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'talos_options': ['--disable-e10s'], 03:26:44 INFO - 'tests': ['tp5o']}, 03:26:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'tests': ['tp5o']}, 03:26:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'talos_options': ['--disable-e10s', 03:26:44 INFO - '--xperf_path', 03:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:44 INFO - 'tests': ['tp5n']}, 03:26:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:44 INFO - 'talos_options': ['--xperf_path', 03:26:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:44 INFO - 'tests': ['tp5n']}}, 03:26:44 INFO - 'talos.zip': {'path': '', 03:26:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:44 INFO - Running post-action listener: _resource_record_post_action 03:26:44 INFO - ##### 03:26:44 INFO - ##### Finished populate-webroot step (success) 03:26:44 INFO - ##### 03:26:44 INFO - ##### 03:26:44 INFO - ##### Running create-virtualenv step. 03:26:44 INFO - ##### 03:26:44 INFO - Running pre-action listener: _resource_record_pre_action 03:26:44 INFO - Running main action method: create_virtualenv 03:26:44 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:44 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 03:26:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:44 INFO - Using real prefix '/usr' 03:26:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:47 INFO - Installing pip.................done. 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:47 INFO - Using env: {'DISPLAY': ':0', 03:26:47 INFO - 'HOME': '/home/cltbld', 03:26:47 INFO - 'LANG': 'en_US.UTF-8', 03:26:47 INFO - 'LANGUAGE': 'en_US:en', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MAIL': '/var/mail/cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SHLVL': '1', 03:26:47 INFO - 'TERM': 'linux', 03:26:47 INFO - 'TMOUT': '86400', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - '_': '/tools/buildbot/bin/python'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 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 03:26:47 INFO - Cleaning up... 03:26:47 INFO - Return code: 0 03:26:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:26:47 INFO - Using env: {'DISPLAY': ':0', 03:26:47 INFO - 'HOME': '/home/cltbld', 03:26:47 INFO - 'LANG': 'en_US.UTF-8', 03:26:47 INFO - 'LANGUAGE': 'en_US:en', 03:26:47 INFO - 'LOGNAME': 'cltbld', 03:26:47 INFO - 'MAIL': '/var/mail/cltbld', 03:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:47 INFO - 'MOZ_NO_REMOTE': '1', 03:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:47 INFO - 'NO_EM_RESTART': '1', 03:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:47 INFO - 'PWD': '/builds/slave/test', 03:26:47 INFO - 'SHELL': '/bin/bash', 03:26:47 INFO - 'SHLVL': '1', 03:26:47 INFO - 'TERM': 'linux', 03:26:47 INFO - 'TMOUT': '86400', 03:26:47 INFO - 'USER': 'cltbld', 03:26:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:47 INFO - '_': '/tools/buildbot/bin/python'} 03:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:47 INFO - Downloading/unpacking psutil>=3.1.1 03:26:47 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 03:26:47 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 03:26:47 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 03:26:47 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 03:26:47 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 03:26:47 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 03:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:49 INFO - Installing collected packages: psutil 03:26:49 INFO - Running setup.py install for psutil 03:26:49 INFO - building 'psutil._psutil_linux' extension 03:26:49 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 03:26:49 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 03:26:49 INFO - building 'psutil._psutil_posix' extension 03:26:49 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 03:26:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:26:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:50 INFO - Successfully installed psutil 03:26:50 INFO - Cleaning up... 03:26:50 INFO - Return code: 0 03:26:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:26:50 INFO - Using env: {'DISPLAY': ':0', 03:26:50 INFO - 'HOME': '/home/cltbld', 03:26:50 INFO - 'LANG': 'en_US.UTF-8', 03:26:50 INFO - 'LANGUAGE': 'en_US:en', 03:26:50 INFO - 'LOGNAME': 'cltbld', 03:26:50 INFO - 'MAIL': '/var/mail/cltbld', 03:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:50 INFO - 'MOZ_NO_REMOTE': '1', 03:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:50 INFO - 'NO_EM_RESTART': '1', 03:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:50 INFO - 'PWD': '/builds/slave/test', 03:26:50 INFO - 'SHELL': '/bin/bash', 03:26:50 INFO - 'SHLVL': '1', 03:26:50 INFO - 'TERM': 'linux', 03:26:50 INFO - 'TMOUT': '86400', 03:26:50 INFO - 'USER': 'cltbld', 03:26:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:50 INFO - '_': '/tools/buildbot/bin/python'} 03:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:50 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 03:26:50 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 03:26:50 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 03:26:50 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 03:26:50 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 03:26:50 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 03:26:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:52 INFO - Installing collected packages: mozsystemmonitor 03:26:52 INFO - Running setup.py install for mozsystemmonitor 03:26:52 INFO - Successfully installed mozsystemmonitor 03:26:52 INFO - Cleaning up... 03:26:52 INFO - Return code: 0 03:26:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:52 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 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:26:52 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 03:26:52 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 03:26:52 INFO - Using env: {'DISPLAY': ':0', 03:26:52 INFO - 'HOME': '/home/cltbld', 03:26:52 INFO - 'LANG': 'en_US.UTF-8', 03:26:52 INFO - 'LANGUAGE': 'en_US:en', 03:26:52 INFO - 'LOGNAME': 'cltbld', 03:26:52 INFO - 'MAIL': '/var/mail/cltbld', 03:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:52 INFO - 'MOZ_NO_REMOTE': '1', 03:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:52 INFO - 'NO_EM_RESTART': '1', 03:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:52 INFO - 'PWD': '/builds/slave/test', 03:26:52 INFO - 'SHELL': '/bin/bash', 03:26:52 INFO - 'SHLVL': '1', 03:26:52 INFO - 'TERM': 'linux', 03:26:52 INFO - 'TMOUT': '86400', 03:26:52 INFO - 'USER': 'cltbld', 03:26:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:52 INFO - '_': '/tools/buildbot/bin/python'} 03:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:52 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 03:26:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:54 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 03:26:54 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 03:26:54 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 03:26:54 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 03:26:54 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 03:26:54 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 03:26:54 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:54 INFO - warning: no files found matching '*.txt' 03:26:54 INFO - no previously-included directories found matching 'build' 03:26:54 INFO - no previously-included directories found matching 'dist' 03:26:54 INFO - no previously-included directories found matching '.git*' 03:26:54 INFO - Installing collected packages: jsonschema, functools32 03:26:54 INFO - Running setup.py install for functools32 03:26:54 INFO - warning: no files found matching '*.txt' 03:26:54 INFO - no previously-included directories found matching 'build' 03:26:54 INFO - no previously-included directories found matching 'dist' 03:26:54 INFO - no previously-included directories found matching '.git*' 03:26:54 INFO - Successfully installed jsonschema functools32 03:26:54 INFO - Cleaning up... 03:26:55 INFO - Return code: 0 03:26:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:55 INFO - Using env: {'DISPLAY': ':0', 03:26:55 INFO - 'HOME': '/home/cltbld', 03:26:55 INFO - 'LANG': 'en_US.UTF-8', 03:26:55 INFO - 'LANGUAGE': 'en_US:en', 03:26:55 INFO - 'LOGNAME': 'cltbld', 03:26:55 INFO - 'MAIL': '/var/mail/cltbld', 03:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:55 INFO - 'MOZ_NO_REMOTE': '1', 03:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:55 INFO - 'NO_EM_RESTART': '1', 03:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:55 INFO - 'PWD': '/builds/slave/test', 03:26:55 INFO - 'SHELL': '/bin/bash', 03:26:55 INFO - 'SHLVL': '1', 03:26:55 INFO - 'TERM': 'linux', 03:26:55 INFO - 'TMOUT': '86400', 03:26:55 INFO - 'USER': 'cltbld', 03:26:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:55 INFO - '_': '/tools/buildbot/bin/python'} 03:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:57 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:57 INFO - Downloading docopt-0.6.1.tar.gz 03:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:57 INFO - Running setup.py install for blobuploader 03:26:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:57 INFO - Running setup.py install for requests 03:26:58 INFO - Running setup.py install for docopt 03:26:58 INFO - Successfully installed blobuploader requests docopt 03:26:58 INFO - Cleaning up... 03:26:58 INFO - Return code: 0 03:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:58 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')]} 03:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:58 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')]} 03:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:58 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 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:26:58 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 03:26:58 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 03:26:58 INFO - Using env: {'DISPLAY': ':0', 03:26:58 INFO - 'HOME': '/home/cltbld', 03:26:58 INFO - 'LANG': 'en_US.UTF-8', 03:26:58 INFO - 'LANGUAGE': 'en_US:en', 03:26:58 INFO - 'LOGNAME': 'cltbld', 03:26:58 INFO - 'MAIL': '/var/mail/cltbld', 03:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:58 INFO - 'MOZ_NO_REMOTE': '1', 03:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:58 INFO - 'NO_EM_RESTART': '1', 03:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:58 INFO - 'PWD': '/builds/slave/test', 03:26:58 INFO - 'SHELL': '/bin/bash', 03:26:58 INFO - 'SHLVL': '1', 03:26:58 INFO - 'TERM': 'linux', 03:26:58 INFO - 'TMOUT': '86400', 03:26:58 INFO - 'USER': 'cltbld', 03:26:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:58 INFO - '_': '/tools/buildbot/bin/python'} 03:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:58 INFO - Running setup.py (path:/tmp/pip-MKLybn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:58 INFO - Running setup.py (path:/tmp/pip-jrCpzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:58 INFO - Running setup.py (path:/tmp/pip-Wy9DAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:58 INFO - Running setup.py (path:/tmp/pip-_7i0Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:58 INFO - Running setup.py (path:/tmp/pip-mlJMYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:59 INFO - Running setup.py (path:/tmp/pip-NAhSxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:59 INFO - Running setup.py (path:/tmp/pip-GUF7YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:59 INFO - Running setup.py (path:/tmp/pip-JdCDxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:59 INFO - Running setup.py (path:/tmp/pip-lUJ8TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:59 INFO - Running setup.py (path:/tmp/pip-oiwByo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:59 INFO - Running setup.py (path:/tmp/pip-k_scAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:59 INFO - Running setup.py (path:/tmp/pip-3TBOe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:59 INFO - Running setup.py (path:/tmp/pip-fZTfnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:59 INFO - Running setup.py (path:/tmp/pip-Cga3j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:59 INFO - Running setup.py (path:/tmp/pip-PgSlYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:59 INFO - Running setup.py (path:/tmp/pip-EYYnJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:59 INFO - Running setup.py (path:/tmp/pip-tokfrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:59 INFO - Running setup.py install for manifestparser 03:27:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozcrash 03:27:00 INFO - Running setup.py install for mozdebug 03:27:00 INFO - Running setup.py install for mozdevice 03:27:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozfile 03:27:00 INFO - Running setup.py install for mozhttpd 03:27:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozinfo 03:27:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozInstall 03:27:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for mozleak 03:27:00 INFO - Running setup.py install for mozlog 03:27:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:00 INFO - Running setup.py install for moznetwork 03:27:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozprocess 03:27:01 INFO - Running setup.py install for mozprofile 03:27:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozrunner 03:27:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Running setup.py install for mozscreenshot 03:27:01 INFO - Running setup.py install for moztest 03:27:01 INFO - Running setup.py install for mozversion 03:27:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:01 INFO - Cleaning up... 03:27:01 INFO - Return code: 0 03:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:01 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 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:27:01 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 03:27:01 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 03:27:01 INFO - Using env: {'DISPLAY': ':0', 03:27:01 INFO - 'HOME': '/home/cltbld', 03:27:01 INFO - 'LANG': 'en_US.UTF-8', 03:27:01 INFO - 'LANGUAGE': 'en_US:en', 03:27:01 INFO - 'LOGNAME': 'cltbld', 03:27:01 INFO - 'MAIL': '/var/mail/cltbld', 03:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:01 INFO - 'MOZ_NO_REMOTE': '1', 03:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:01 INFO - 'NO_EM_RESTART': '1', 03:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:01 INFO - 'PWD': '/builds/slave/test', 03:27:01 INFO - 'SHELL': '/bin/bash', 03:27:01 INFO - 'SHLVL': '1', 03:27:01 INFO - 'TERM': 'linux', 03:27:01 INFO - 'TMOUT': '86400', 03:27:01 INFO - 'USER': 'cltbld', 03:27:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:01 INFO - '_': '/tools/buildbot/bin/python'} 03:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:01 INFO - Running setup.py (path:/tmp/pip-CGN7Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:02 INFO - Running setup.py (path:/tmp/pip-S0Z55z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 INFO - Running setup.py (path:/tmp/pip-GiI7fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 INFO - Running setup.py (path:/tmp/pip-oICqub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:02 INFO - Running setup.py (path:/tmp/pip-xaei1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 INFO - Running setup.py (path:/tmp/pip-jTgrPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 INFO - Running setup.py (path:/tmp/pip-l4OT6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:02 INFO - Running setup.py (path:/tmp/pip-62NGtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:02 INFO - Running setup.py (path:/tmp/pip-fur2tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:02 INFO - Running setup.py (path:/tmp/pip-qO1xpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:02 INFO - Running setup.py (path:/tmp/pip-kr_lq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:02 INFO - Running setup.py (path:/tmp/pip-5Bl4cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:02 INFO - Running setup.py (path:/tmp/pip-EQAYs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:02 INFO - Running setup.py (path:/tmp/pip-gffRXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:02 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)) 03:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:02 INFO - Running setup.py (path:/tmp/pip-oOacW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:03 INFO - Running setup.py (path:/tmp/pip-oCrn90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:03 INFO - Running setup.py (path:/tmp/pip-AckmKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:05 INFO - Downloading blessings-1.6.tar.gz 03:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:05 INFO - Installing collected packages: blessings 03:27:05 INFO - Running setup.py install for blessings 03:27:05 INFO - Successfully installed blessings 03:27:05 INFO - Cleaning up... 03:27:05 INFO - Return code: 0 03:27:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:05 INFO - Reading from file tmpfile_stdout 03:27:05 INFO - Current package versions: 03:27:05 INFO - argparse == 1.2.1 03:27:05 INFO - blessings == 1.6 03:27:05 INFO - blobuploader == 1.2.4 03:27:05 INFO - docopt == 0.6.1 03:27:05 INFO - functools32 == 3.2.3-2 03:27:05 INFO - jsonschema == 2.5.1 03:27:05 INFO - manifestparser == 1.1 03:27:05 INFO - mozInstall == 1.12 03:27:05 INFO - mozcrash == 0.17 03:27:05 INFO - mozdebug == 0.1 03:27:05 INFO - mozdevice == 0.48 03:27:05 INFO - mozfile == 1.2 03:27:05 INFO - mozhttpd == 0.7 03:27:05 INFO - mozinfo == 0.9 03:27:05 INFO - mozleak == 0.1 03:27:05 INFO - mozlog == 3.2 03:27:05 INFO - moznetwork == 0.27 03:27:05 INFO - mozprocess == 0.22 03:27:05 INFO - mozprofile == 0.28 03:27:05 INFO - mozrunner == 6.11 03:27:05 INFO - mozscreenshot == 0.1 03:27:05 INFO - mozsystemmonitor == 0.3 03:27:05 INFO - moztest == 0.7 03:27:05 INFO - mozversion == 1.4 03:27:05 INFO - psutil == 3.1.1 03:27:05 INFO - requests == 1.2.3 03:27:05 INFO - wsgiref == 0.1.2 03:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:05 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 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:27:05 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 03:27:05 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 03:27:05 INFO - Using env: {'DISPLAY': ':0', 03:27:05 INFO - 'HOME': '/home/cltbld', 03:27:05 INFO - 'LANG': 'en_US.UTF-8', 03:27:05 INFO - 'LANGUAGE': 'en_US:en', 03:27:05 INFO - 'LOGNAME': 'cltbld', 03:27:05 INFO - 'MAIL': '/var/mail/cltbld', 03:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:05 INFO - 'MOZ_NO_REMOTE': '1', 03:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:05 INFO - 'NO_EM_RESTART': '1', 03:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:05 INFO - 'PWD': '/builds/slave/test', 03:27:05 INFO - 'SHELL': '/bin/bash', 03:27:05 INFO - 'SHLVL': '1', 03:27:05 INFO - 'TERM': 'linux', 03:27:05 INFO - 'TMOUT': '86400', 03:27:05 INFO - 'USER': 'cltbld', 03:27:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:05 INFO - '_': '/tools/buildbot/bin/python'} 03:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 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)) 03:27:05 INFO - Cleaning up... 03:27:05 INFO - Return code: 0 03:27:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:05 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 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:27:05 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 03:27:05 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 03:27:05 INFO - Using env: {'DISPLAY': ':0', 03:27:05 INFO - 'HOME': '/home/cltbld', 03:27:05 INFO - 'LANG': 'en_US.UTF-8', 03:27:05 INFO - 'LANGUAGE': 'en_US:en', 03:27:05 INFO - 'LOGNAME': 'cltbld', 03:27:05 INFO - 'MAIL': '/var/mail/cltbld', 03:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:05 INFO - 'MOZ_NO_REMOTE': '1', 03:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:05 INFO - 'NO_EM_RESTART': '1', 03:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:05 INFO - 'PWD': '/builds/slave/test', 03:27:05 INFO - 'SHELL': '/bin/bash', 03:27:05 INFO - 'SHLVL': '1', 03:27:05 INFO - 'TERM': 'linux', 03:27:05 INFO - 'TMOUT': '86400', 03:27:05 INFO - 'USER': 'cltbld', 03:27:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:05 INFO - '_': '/tools/buildbot/bin/python'} 03:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:06 INFO - Cleaning up... 03:27:06 INFO - Return code: 0 03:27:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff5609c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', '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 03:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:27:06 INFO - Using env: {'DISPLAY': ':0', 03:27:06 INFO - 'HOME': '/home/cltbld', 03:27:06 INFO - 'LANG': 'en_US.UTF-8', 03:27:06 INFO - 'LANGUAGE': 'en_US:en', 03:27:06 INFO - 'LOGNAME': 'cltbld', 03:27:06 INFO - 'MAIL': '/var/mail/cltbld', 03:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:06 INFO - 'MOZ_NO_REMOTE': '1', 03:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:06 INFO - 'NO_EM_RESTART': '1', 03:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:06 INFO - 'PWD': '/builds/slave/test', 03:27:06 INFO - 'SHELL': '/bin/bash', 03:27:06 INFO - 'SHLVL': '1', 03:27:06 INFO - 'TERM': 'linux', 03:27:06 INFO - 'TMOUT': '86400', 03:27:06 INFO - 'USER': 'cltbld', 03:27:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:06 INFO - '_': '/tools/buildbot/bin/python'} 03:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:06 INFO - Downloading/unpacking flake8 03:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:27:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:27:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:27:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:08 INFO - no previously-included directories found matching 'docs/_build' 03:27:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:27:08 INFO - Running setup.py install for pep8 03:27:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:27:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:27:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:27:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:27:09 INFO - no previously-included directories found matching 'docs/_build' 03:27:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:27:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:27:09 INFO - Cleaning up... 03:27:09 INFO - Return code: 0 03:27:09 INFO - Running post-action listener: _resource_record_post_action 03:27:09 INFO - Running post-action listener: _start_resource_monitoring 03:27:09 INFO - Starting resource monitoring. 03:27:09 INFO - ##### 03:27:09 INFO - ##### Finished create-virtualenv step (success) 03:27:09 INFO - ##### 03:27:09 INFO - ##### 03:27:09 INFO - ##### Running install step. 03:27:09 INFO - ##### 03:27:09 INFO - Running pre-action listener: _resource_record_pre_action 03:27:09 INFO - Running main action method: install 03:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:09 INFO - Reading from file tmpfile_stdout 03:27:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:09 INFO - Reading from file tmpfile_stdout 03:27:09 INFO - Output received: 03:27:09 INFO - Usage: mozinstall [options] installer 03:27:09 INFO - Options: 03:27:09 INFO - -h, --help show this help message and exit 03:27:09 INFO - -d DEST, --destination=DEST 03:27:09 INFO - Directory to install application into. [default: 03:27:09 INFO - "/builds/slave/test"] 03:27:09 INFO - --app=APP Application being installed. [default: firefox] 03:27:09 INFO - mkdir: /builds/slave/test/build/application 03:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:27:25 INFO - Reading from file tmpfile_stdout 03:27:25 INFO - Output received: 03:27:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:25 INFO - Running post-action listener: _resource_record_post_action 03:27:25 INFO - ##### 03:27:25 INFO - ##### Finished install step (success) 03:27:25 INFO - ##### 03:27:25 INFO - ##### 03:27:25 INFO - ##### Running run-tests step. 03:27:25 INFO - ##### 03:27:25 INFO - Running pre-action listener: _resource_record_pre_action 03:27:25 INFO - Running main action method: run_tests 03:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:25 INFO - Python 2.7.3 03:27:25 INFO - Return code: 0 03:27:25 INFO - grabbing minidump binary from tooltool 03:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:25 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 0x18792e0>, '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 0x17e5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:25 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 03:27:25 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 03:27:25 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 03:27:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:25 INFO - Return code: 0 03:27:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:27:26 INFO - Return code: 0 03:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:27:26 INFO - Using env: {'DISPLAY': ':0', 03:27:26 INFO - 'HOME': '/home/cltbld', 03:27:26 INFO - 'LANG': 'en_US.UTF-8', 03:27:26 INFO - 'LANGUAGE': 'en_US:en', 03:27:26 INFO - 'LOGNAME': 'cltbld', 03:27:26 INFO - 'MAIL': '/var/mail/cltbld', 03:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:26 INFO - 'MOZ_NO_REMOTE': '1', 03:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:26 INFO - 'NO_EM_RESTART': '1', 03:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:26 INFO - 'PWD': '/builds/slave/test', 03:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:26 INFO - 'SHELL': '/bin/bash', 03:27:26 INFO - 'SHLVL': '1', 03:27:26 INFO - 'TERM': 'linux', 03:27:26 INFO - 'TMOUT': '86400', 03:27:26 INFO - 'USER': 'cltbld', 03:27:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739', 03:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:26 INFO - '_': '/tools/buildbot/bin/python'} 03:27:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:27:26 INFO - mozversion application_buildid: 20160607004038 03:27:26 INFO - mozversion application_changeset: e70892847544db94d801f80543fe8a7f6d836f90 03:27:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:27:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:26 INFO - mozversion application_name: Firefox 03:27:26 INFO - mozversion application_remotingname: firefox-dev 03:27:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:26 INFO - mozversion application_vendor: Mozilla 03:27:26 INFO - mozversion application_version: 49.0a2 03:27:26 INFO - mozversion platform_buildid: 20160607004038 03:27:26 INFO - mozversion platform_changeset: e70892847544db94d801f80543fe8a7f6d836f90 03:27:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:27:26 INFO - mozversion platform_version: 49.0a2 03:27:26 INFO - using testdate: 1465295246 03:27:26 INFO - actual date: 1465295246 03:27:26 INFO - starting webserver on 'localhost:48508' 03:27:26 INFO - SUITE-START | Running 2 tests 03:27:26 INFO - TEST-START | dromaeo_css 03:27:26 INFO - operating with platform_type : linux_ 03:27:26 INFO - Initialising browser for dromaeo_css test... 03:27:26 INFO - TEST-INFO | started process 8096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnmy37p/profile http://localhost:48508/getInfo.html) 03:27:31 INFO - PROCESS | 8096 | __metrics Screen width/height:1600/1200 03:27:31 INFO - PROCESS | 8096 | colorDepth:24 03:27:31 INFO - PROCESS | 8096 | Browser inner width/height: 1024/697 03:27:31 INFO - PROCESS | 8096 | __metrics 03:27:32 ERROR - PROCESS | 8096 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 03:27:32 INFO - TEST-INFO | 8096: exit 0 03:27:32 INFO - Browser initialized. 03:27:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:32 INFO - TEST-INFO | started process 8229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnmy37p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:44 INFO - PROCESS | 8229 | RSS: Main: 156319744 03:27:44 INFO - PROCESS | 8229 | 03:28:34 INFO - PROCESS | 8229 | 1465295314391 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] 03:30:42 INFO - PROCESS | 8229 | Cycle 1(1): loaded http://localhost:48508/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48508/tests/dromaeo/cssquery-ext.html) 03:30:43 INFO - PROCESS | 8229 | RSS: Main: 160501760 03:30:43 INFO - PROCESS | 8229 | 03:33:45 INFO - PROCESS | 8229 | Cycle 1(1): loaded http://localhost:48508/tests/dromaeo/cssquery-ext.html (next: http://localhost:48508/tests/dromaeo/cssquery-jquery.html) 03:33:45 INFO - PROCESS | 8229 | RSS: Main: 157646848 03:33:45 INFO - PROCESS | 8229 | 03:36:47 INFO - PROCESS | 8229 | Cycle 1(1): loaded http://localhost:48508/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48508/tests/dromaeo/cssquery-mootools.html) 03:36:48 INFO - PROCESS | 8229 | RSS: Main: 156823552 03:36:48 INFO - PROCESS | 8229 | 03:39:50 INFO - PROCESS | 8229 | Cycle 1(1): loaded http://localhost:48508/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48508/tests/dromaeo/cssquery-prototype.html) 03:39:50 INFO - PROCESS | 8229 | RSS: Main: 156925952 03:39:50 INFO - PROCESS | 8229 | 03:42:53 INFO - PROCESS | 8229 | Cycle 1(1): loaded http://localhost:48508/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48508/tests/dromaeo/cssquery-yui.html) 03:42:53 INFO - PROCESS | 8229 | RSS: Main: 159023104 03:42:53 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | Cycle 1(1): loaded http://localhost:48508/tests/dromaeo/cssquery-yui.html (next: http://localhost:48508/tests/dromaeo/cssquery-dojo.html) 03:45:56 INFO - PROCESS | 8229 | RSS: Main: 159797248 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | __start_tp_report 03:45:56 INFO - PROCESS | 8229 | _x_x_mozilla_page_load 03:45:56 INFO - PROCESS | 8229 | _x_x_mozilla_page_load_details 03:45:56 INFO - PROCESS | 8229 | |i|pagename|runs| 03:45:56 INFO - PROCESS | 8229 | |0;dojo.html;3389.7627166098378;3404.5744281964753;3411.1131105912455;3444.8794292199777;3455.6717111874364;5701.03082475979;5725.971370143148;5802.5938184327115;5834.533237341018;5835.328937172227;5762.366139724627;5794.565407594437;5865.999999999989;5869.9706501467535;5885.264341957255;5208.661437006592;5228.372595288571;5261.710605916673;5265.76304066318;5288.365396152448;5081.085404627165;5109.310243117187;5123.129068058421;5305.920411193835;5313.468653134694;5200.3759548854005;5209.400918894319;5218.739063046852;5220.686758794484;5224.529792318691;5250.107481728096;5261.657992230493;5274.630775845673;5289.788408463657;5326.83306165785;5003.349564556621;5173.405058418292;5217.973910130425;5267.789288428458;5279.260903473517;5518.696471694056;5530.917036244459;5616.354119276295;5622.100463925753;5625.774969001235;6136.846578835565;6165.630062196283;6168.074788781674;6199.473044791198;6201.534884883652;6227.470664993436;6233.625982441068;6236.594621349598;6242.157308763304;6268;5731.083026715747;5770.682612456313;5797.710114494301;5807.796727114573;5842.707864606795;6371.076193951851;6389.840253993687;6414.294427612959;6423.5503514754455;6429.8714025720155;6063.393660633901;6186.628802271788;6190.535709821781;6205.22434695663;6205.2553693557065;6057.273127224761;6084.239470066242;6090.299615544269;6115.724792384264;6151.179988745391;6133;6171.660558669227;6184.6598437085495;6188.690565471708;6190.380961903774;6078.817635470943;6144.723487443076;6161.691915404212;6176.444120029129;6185.938140618626;4665.813367465331;4677.111348843709;4717.033008233304;4740.762961851894;4755.809767609326;4222.59885310895;4231.555686652857;4234.364845273172;4247.915041699211;4261.765602891809;5791.855203619859;5811.535077193815;6011.3086994995265;6011.338752737195;6032.125341825411;6091.269047714302;6111.865232675556;6124.228368151176;6197.907031394533;6291.402316779899;5931.733072011683;5955.166276721263;5964.701764911737;5970.940290597126;5985.191999080069;5240.554552863049;5240.71176085319;5315.6279060465395;5340.305760251143;5360.624756267024;6356.523260755369;6436.388543088399;6459.773907913201;6471.0940468334475;6492;6223.190985171989;6240.937590624036;6241.032639940817;6282.497400207881;6287.96856015717;6240.937590624036;6280.685965701605;6309.05364195356;6466.805995820133;6475.838104047248;6112.437810945274;6115.362036198588;6124.320821494513;6136.457808108435;6136.764169924236;6173.290071641819;6244.65654389013;6246.968765156145;6251.9062214067735;6260.561760676709;5955.76176952917;5998.640081595118;6012.819615411545;6052.606580572248;6074.969625151846;6033.728482218398;6108.541859360655;6120.17377654011;6126.356732543197;6130.172426722335;5990.400959903975;6026.0659597762415;6031.24609423822;6034.336223015553;6046.606970546901;6007.54943379257;6041.18444010053;6045.818625441244;6113.23584551931;6168.105624684305;6009.278886533644;6049.425304596057;6050.546209034252;6052.848678783065;6062.666553339609 03:45:56 INFO - PROCESS | 8229 | |1;ext.html;575.3010092737323;634.3086036220519;663.5056882622443;673.027475298194;674.3256743256743;41073.38389924153;45683;45838.541614583846;45853.31220031698;45876.54123458765;47783;48405;48455.75772121135;48510.27234591484;48618.75690621542;8838.5580720964;8956.820863582725;8969.058248883872;8971.147740964598;8984.19142277195;8719.520426376546;8773.03496615375;8823.735287941372;8828.779280517974;8839.07189745077;8942.955285223565;8988.910110898873;9001.909980900205;9012.098790120968;9020.503872287021;8904.643814247422;8926.86609700855;8944.731658050268;8967.506787126706;8978.685745998891;8817.867731984026;8970.058143894928;8980.191782739585;8998.685046023424;9045.231155351803;44011;44381.33995930413;44402.77798611019;44447.77776111131;44454.33318500225;3806.010437286298;3841.5966323536186;3875.6511913927884;3878.3600705883496;4077.245709543744;34445.483317750004;34922;35003.299934001174;35577.82211088928;36822;4545.659075569312;4558.77206139695;4594.770261486946;4651.55810198034;4685.953140468586;367496;368911;369199;370315.29684703075;371183.9999999973;64157;64170.679146603965;64354.678226608565;64458;64697.02954455687;39736.2052758949;40598.79700601478;40601;41980.16039679189;42353.57646423558;17241.56896077608;17330.133493325535;17356.91321543384;17449.825501745076;17514.299428022736;12969.286689232184;13092.083554151119;13135.752103550147;13139.080264381593;13146.145500542625;21462.24882129118;21733.34799956004;21741.67387489189;21868.23461178883;21902.780972190394;7301.269873012762;7566.281203285679;7570.394368450511;7651.732189373457;7950.7217247396065;1079.681493959284;1113.7995160871121;1138.0781566930812;1195.384377045822;1285.9614211573669;33957.490637640454;33971.32057358839;34208.65791342105;34447.82776086104;34470;1199.5321824488456;1214.1864950483198;1238.4674589926237;1295.378218455147;1330.9267990260628;17446.38937637202;17649.294028238983;17679.05530391656;17858.5535361617;17957.281708731767;167553;622711;640157;643092;1033171;67095.66452167708;67286.32713672899;67596;67680.32319676838;67912.98130528047;1468.2511918921214;1494.9850501495064;1524.3978628441703;1529.8164220293413;1539.3457780443266;33933.32133357369;34300.31399371949;34455.31089378249;34508.48237276493;34725.82637086798;54676.45323546714;55291.72354138204;55448.44551554433;55565;55586.72206639103;525065;539487;540362;540808;540841;31137.844310778302;31256.21859453441;31376;31507;31577.36845263128;52023.73988130035;52941.47058529365;53072.203916942046;53167.734161328946;53781;43072.56927430811;43830;43918;44424.77787611041;44719.77640111909;43541;43715;44039.77980110079;44503.55496444994;44673.776631116634;43702.344464832415;44257;45556.77221613871;45688.771556142005;47804.7609761949;40097.59902401055;40163.39754903737;40210.79894600508;40670.38994415027;40726.1854762909;30264.69735302619;30612.693873060984;30645.23386915345;30831.84584077155;31374.215644609067 03:45:56 INFO - PROCESS | 8229 | |2;jquery.html;432.46374495625423;433.1488624852165;433.54477798311774;435.8434505420989;440.46483522520134;18722.719159212607;19829.206831726715;19922.501937451572;20538;20565.897170514163;19110.044497775125;19142.330018449356;19359.322423715173;19823.5044123897;19843.900780496115;5851.79518716845;5987.43119403656;5994.340622531518;6018.759249630009;6019.187409699678;5851.8537036574;5929.110633404981;5947.40525947404;5957.731902064417;5958.40415958405;5883.558733095014;5890.410958904118;5914.792982245623;5922.407759224065;5940.2277703898435;5610.635308704942;5741.081426971686;5883.61756485827;5897.32180799205;5917.378675239124;5737.942620573825;5740.82777516671;5772.7113644317615;5782.7108644568025;5805.883882322372;14869;16783.66432671352;22561;23900.880495597412;23920.521589568285;2411.3248290478696;2431.270618814366;2623.5015347084186;2960.3931194105157;3088.104449709604;9777.804443911082;10440.164786817037;10455.424951627658;10616.681499555025;10931.726706832313;1994.3618042226494;2030.4111807575784;2056.650369437199;2086.7182930304516;2093.6859471079306;83773;86604;87831.56084219538;88159;89247.55376223143;10181.94909025465;10496.947515262375;10779.946100269448;10797.892021079688;10997.12023038155;15052.698946021237;15199.164045977357;15201.695966080617;15262.160581168142;15298.694026119638;7723.382129429632;7906.841863162705;7970.163132871081;8111.9594402027615;8149.348052155813;7793.337566306927;7811.4922530035365;7836.960815195887;7907.169747176578;7918.841623167619;4630.513796051433;4705.364775755229;4706.294055891643;4761.476237613929;4785.617150627942;1992.3923203423094;2050.7744148143693;2061.711360409544;2075.1803037799987;2112.788721127906;928.8792456980549;978.9510524473748;1067.2209287220373;1103.6854496468468;1118.4072441605963;19325.90337048334;19802;19882.005899704956;19915;20180.697289540374;1016.1870503597092;1027.7225149209671;1044.4464433849919;1060.4273692206277;1123.6292023632182;10673.25287229902;11174.66476005721;11332.943335283271;11388.316700997966;11397.544098236143;471221;473430;485218;490722;494863;72045.91931121037;91392.54303728438;91652;92078;98883.01116988738;1043.95824167034;1052.1214785654065;1070.4273213830718;1089.9237053406343;1090.2477290669572;17875.37436189727;17963.28146874163;18167.545811354823;18262.452126436227;18304.176312066254;41630.37554436747;42181.1563768729;42274.36588451237;42866.78566607147;43084;59851.401485984585;59863.40136598578;60223;61868.69065654643;62399.376006241175;9047.68333108338;9170.495622740547;9212.124848139416;9226.907730922874;9283.11810378013;12370.195937264049;13527.25600091965;13691.178529288274;13759.931200343934;13773.380197890918;11945.462454189408;12000.879991199976;12105.576304829288;12123.515059397525;12222.083343749076;11174.106071514097;11472;11839.28964262147;12173.147879648694;12334;11996.100292477924;12138.211016283913;12228.877711222774;12361.93819030899;12602.243865368107;7923.128455869965;8309.127541608044;8963.507007114671;9031.864522032043;9432.575534101119;10982.087585118827;11956.103292252941;12135.393230338625;12202.75594488123;12329.383530823603 03:45:56 INFO - PROCESS | 8229 | |3;mootools.html;1531.0966529747448;1565.1235308227394;1792.7042038063712;1912.168206830028;1941.9998700669157;8028.558429286387;9113.179813816756;9178.86231706524;9823.312368134233;9890.456024918627;9160.312976526771;9408.905910940888;9459.101385368396;9464.384814987021;9562.378445401062;2378.3340664613893;2384.988075059622;2405.915792947247;2409.325388891113;2410.288964755401;2396.700412448444;2398.5322862041908;2419.7096348438213;2433.6592876997233;2438.817088718344;2204.40481070111;2212.6017316882953;2286.4741109544816;2421.5641184586766;2437;2299.2297580310533;2305.5043165719453;2324.8840556532873;2339.7192336919593;2342.472943587696;2093.2464312847364;2097.528056187361;2101.075526768217;2111.4615772977945;2183.661532462455;9410.811783764355;9511.048895110504;9515.762105947337;9517.714468565953;9525.14273715362;5434.157705555645;5536.584756143265;5565.220869078333;5590.217369568264;5590.692511911843;3385.492176173569;3435.3644575753315;3465.358908601917;3575.249197668493;3601.4957905893198;1172.4255114993678;1184.5498710489958;1195.4022988505747;1206.8129439936824;1212.8362671039474;13205.07564470497;13333.266670333127;13394.464221431228;13417;13527.391267392892;4855.223164293767;4888.780004899788;4955.529224723718;4981.32752078472;5042.294078828967;10678.1991350649;10721.142308615292;10745.24783265164;10749.677509674722;10809.67570972872;5521.4478552144465;5585.804496842591;5600.887982240414;5615.522680572197;5638.154276858504;4645.628349732014;5085.3134826797905;5093.108705976513;5241.475852414728;5255.02781985334;4215.220184265921;4256.106217694319;4404.295312749945;4416.028473735773;4442;1322.451182759144;1329.1360615599745;1333.4266265505926;1339.6583871112805;1361.8297712785902;1052.4422056310168;1053.878803937557;1062.930909490896;1064.9680509584725;1065.7388939709665;6173.56785025044;6378.457831084317;6433.099366088752;6433.646149461731;6458.613309442114;480.9206480930677;491.09883364026695;491.17972985114943;491.86473719726644;496.96878976124685;4184;4194.559571245037;4262.87211383659;4284.1645879053285;4298.484181898192;11708.824367634492;11981.88018119825;11983.64049078529;12006.51973921051;12013.579524716593;11832.822507662391;11859.525618975144;11894.345810980307;11929.463174157183;11943.761124777457;8617.267532259702;8782.385233033754;8862.911370886208;9013.909860901307;9203.355765096512;6335.809925702236;6463.870722585616;6501.8699626008165;6509.707063182263;6615.470762339098;10367.222458315808;10575.524101415609;10598.417087060287;10785.514651840844;10836;10667.146628269564;11182.161337899854;11247.7750444989;11354.829677554679;11453.828192576952;7442.665080071301;8263.297619702393;8434.873476897974;8597.312215022908;8713.259372953116;9404.811903762024;9408.247340212629;9455.149036586465;9467.431954082776;9476.431414115175;8299.460535065202;8424.28393586552;8545.102764209669;8547.316214702932;8641.351898607756;8010.3992200584025;8137.7965550859335;8342.29090527312;8422.199891010345;8518.063013068682;7757.224277572198;7825.452218344662;7895.7236496722335;7932.484388514728;7938.960305198437;5549.278593782782;5596.440355964371;5637.830865074055;5782.508486778671;5800.39095894925;5789.94210057894;5856.238688970407;5864.501517370901;5879.441453061952;5969.464811759424 03:45:56 INFO - PROCESS | 8229 | |4;prototype.html;350.9631488693687;351.1589742566553;351.96304388039255;354.9493499242243;358.75604588879554;5861.589688721791;5885.8234252972425;5886.735096920638;5888.704485013291;5902.203202567652;5788.2376455304075;5808.477237048664;5842.182094506772;5851.15158302046;5876.9118463223085;4237.809298581564;4404.317330813729;4417.337399390101;4430.667699922503;4434.512203657611;4373.540778218289;4431.800568974388;4432.623227025707;4436.822527098912;4462.977685111586;4401.735895846244;4421.646268298545;4452.131834292314;4489.730616163024;4498.640108791289;4239.258129827268;4450.421445212134;4474.105178964221;4480.462344518646;4507.233770259064;3889.5414219667623;3903.7072219583647;3909.1009067914256;3918.0792513759243;3923.7645741255333;5666.716664166775;5687.26065611472;5692.31692196939;5750.223719797816;5766.394528574481;4907.11671899058;5148.944466384382;5162.483751624845;5183.559397451221;5201.271821944931;6110.908336374958;6152.507799376039;6154.415330543591;6154.476869466101;6155.214987653575;4364.323529852878;4366.8471603494045;4399.120175964787;4399.23013472641;4400.09797991411;6106;6150.169727086831;6309.463695585835;6365.013422919455;6370.528062206109;4396.494403143615;4397.824087036547;4403.9779801100785;4406.691531592758;4470.128324976663;4501.212287849613;4503.774811259424;4510.21071312519;4547.727136371828;4575.359449677047;4949.133901567211;5183.248428977777;5202.97398513005;5209.765560549784;5211.60912931524;6071.969640151771;6100.877982440326;6119.164250724764;6177.69111544421;6183.381661833871;1527.6791873706425;1554.2927967774635;1564.4368027510088;1566.7074663402739;1570.7251231034522;951.70497145885;979.294907666479;992.265723364705;999.160705007797;1005.5374527717186;5280.867978300496;5368.1548779147115;5369.40936496985;5386.353637563439;5405.621606487587;5563.916541251884;5607.018771714934;5609.5792815539;5669.376368599451;5681.886362272731;5325.813596524103;5340.49265319794;5535.418781028015;6017.729202185912;6033.969830150909;3371.696547310754;3383.796972181677;3386.1873150443716;3388.119089036868;3398.6091599466376;6329.968350158219;6489.448396886318;6501.284858665543;6521.282658907517;6559.770408035696;6499.570094579185;6506.41442270198;6518.706658200393;6523.510736694767;6539.444147247537;6356.205474315803;6537.34626537352;6590.176227971504;6604.768833090819;6614.173228346457;6356.459700925473;6434.648723768061;6437.774677886251;6446;6467.611943283418;6181.938180618136;6196.907046394398;6229.657368844757;6282.465990390685;6302.621842689453;6575.178102737158;6599.340065993362;6611.33886611335;6618.867622647616;6620.3710647488415;4343.782810859508;4402.757848318373;4411.691181617256;4416.889577760582;4437.977810110929;6248.281447633581;6325.367463253638;6415.166028416276;6418.293987661447;6438.742450302123;6156.692165391623;6209.720562574605;6236.812895613139;6246.46905013079;6252.937470625236;6016.849578760566;6200.3799620037635;6202.81391558254;6203.5731781689565;6247.470179348654;6114.2357205349335;6121.632702037892;6127.234095738033;6134.938650613437;6169.475594574512;6314.5792196755365;6357.376295511514;6361.363863613602;6361.395667411589;6371.93628063732;5934.940650593611;6110.602810817282;6211;6216.601264715403;6236.532260080421 03:45:56 INFO - PROCESS | 8229 | |5;yui.html;776.7747353267551;792.1484404265416;796.2276591706051;797.2744802229972;810.4003037752061;15579.454719084833;16873.746893796604;17011.234494447748;17167;17188.570285742862;15514.224288785572;15683.137427441514;15805.051696898165;15811.288492017859;15840.20798960053;708.1007120956382;832.342449464922;833.0794472108324;847.8346722389136;848.7793173774801;849.8555245608261;859.1108203009886;859.9699010534632;860.8880845490108;862.3273846399818;897.6050537763364;898.2589363774879;901.5672477210943;902.5848109869468;904.674317245791;893.2942975049702;895.5343221524803;896.5472436419632;899.6401439424217;899.8245342158282;664.5481072870447;665.012456502094;665.6738198282807;668.759246671198;669.5948950884693;14842.777358339634;14914.17972011539;14948.252587370587;15001.099934003994;15030.473933412279;15650.921745391313;15942.521724348288;16109.677806443922;16158.353665853352;16170.191490425432;12361.876381236252;12554.435050422753;12595.225495971328;12871.292078935654;12885.549005784846;4023.4769479967417;4105.712600117993;4141.233871733709;4155.127423241123;4171.645410140141;79800.60099699523;81854;82628.17371826325;82668.58665706693;83335;11999.400029998465;12219.327936963553;12227.638398203277;12273.324967126715;12519.93740031294;22214.777852221596;22246.332610021724;22282.442938926655;22387.776122238894;22486;8668.479891206547;8959.865602015974;9016.774580635405;9134.132257435533;9198.126178013077;4940.604751619861;4993.450720420751;5055.721935293521;5116.488351164854;5154.201098829687;3672.797996110186;3827.8468861245237;3833.041739565109;3836.731428800013;3838.5777564467885;634.8857205703018;646.8835609590319;653.330336405179;659.6042374575312;664.0106241699832;585.841822707875;642.9614223146626;701.719312275094;724.6014691919529;752.2890868129674;9945.30382873192;10283.485825708834;10396.896031039592;10452.477376131163;10608.787824243625;667.8731041102175;671.7951024937344;672.7309076369492;684.6234570985938;697.6755808549049;4779.044191161782;4801.95198048015;4824.517548245148;4853.587445067138;4981.178105612606;76078.23921760712;122060.84347804563;123443;123598;126381;70335.2966470339;89977.55011224902;91580.54209729042;106367;107166;90980.09019909849;95098.52450737702;95827.52086239663;96370;99066;9948.950255248677;10125.746856328651;10234.744131396774;10407.895921040692;10600.787984240425;41508.58491415047;53660;55189.72405137949;56468.15297770619;56671.716641416526;69296.6535167341;70941.29058709346;71549;77486.22513775015;81513.18486815294;12895.677608059874;13440.596782096552;13519.256440895451;13575.52485662997;14258;14579.92710036443;15201;15437.922810385877;15813.920930395274;16316.428924988044;14601.54139520095;14630.926845366132;15057.247137643293;15085.321160548021;15203.163825989235;14244.786328205293;14523.78214326807;14612.561623151323;14725.852741472449;14848.40606375733;14738.852611474176;15058.32237549291;15302.923485382502;15347.923260383626;15380.307886145374;11104.833427498432;11480.368579728196;11495.310281383145;11629.476673549541;11647;11433.824442843234;12068.500404648012;12264.38678066111;12472.126951113698;12541 03:45:56 INFO - PROCESS | 8229 | __end_tp_report 03:45:56 INFO - PROCESS | 8229 | __start_cc_report 03:45:56 INFO - PROCESS | 8229 | _x_x_mozilla_cycle_collect,337 03:45:56 INFO - PROCESS | 8229 | __end_cc_report 03:45:56 INFO - PROCESS | 8229 | __startTimestamp1465296356303__endTimestamp 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | ------- Summary: start ------- 03:45:56 INFO - PROCESS | 8229 | Number of tests: 6 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | [#0] dojo.html Cycles:165 Average:5755.58 Median:6032.13 stddev:657.38 (10.9%) stddev-sans-first:632.66 03:45:56 INFO - PROCESS | 8229 | Values: 3389.8 3404.6 3411.1 3444.9 3455.7 5701.0 5726.0 5802.6 5834.5 5835.3 5762.4 5794.6 5866.0 5870.0 5885.3 5208.7 5228.4 5261.7 5265.8 5288.4 5081.1 5109.3 5123.1 5305.9 5313.5 5200.4 5209.4 5218.7 5220.7 5224.5 5250.1 5261.7 5274.6 5289.8 5326.8 5003.3 5173.4 5218.0 5267.8 5279.3 5518.7 5530.9 5616.4 5622.1 5625.8 6136.8 6165.6 6168.1 6199.5 6201.5 6227.5 6233.6 6236.6 6242.2 6268.0 5731.1 5770.7 5797.7 5807.8 5842.7 6371.1 6389.8 6414.3 6423.6 6429.9 6063.4 6186.6 6190.5 6205.2 6205.3 6057.3 6084.2 6090.3 6115.7 6151.2 6133.0 6171.7 6184.7 6188.7 6190.4 6078.8 6144.7 6161.7 6176.4 6185.9 4665.8 4677.1 4717.0 4740.8 4755.8 4222.6 4231.6 4234.4 4247.9 4261.8 5791.9 5811.5 6011.3 6011.3 6032.1 6091.3 6111.9 6124.2 6197.9 6291.4 5931.7 5955.2 5964.7 5970.9 5985.2 5240.6 5240.7 5315.6 5340.3 5360.6 6356.5 6436.4 6459.8 6471.1 6492.0 6223.2 6240.9 6241.0 6282.5 6288.0 6240.9 6280.7 6309.1 6466.8 6475.8 6112.4 6115.4 6124.3 6136.5 6136.8 6173.3 6244.7 6247.0 6251.9 6260.6 5955.8 5998.6 6012.8 6052.6 6075.0 6033.7 6108.5 6120.2 6126.4 6130.2 5990.4 6026.1 6031.2 6034.3 6046.6 6007.5 6041.2 6045.8 6113.2 6168.1 6009.3 6049.4 6050.5 6052.8 6062.7 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | [#1] ext.html Cycles:180 Average:67279.62 Median:44148.39 stddev:145800.99 (330.3%) stddev-sans-first:146123.99 03:45:56 INFO - PROCESS | 8229 | Values: 575.3 634.3 663.5 673.0 674.3 41073.4 45683.0 45838.5 45853.3 45876.5 47783.0 48405.0 48455.8 48510.3 48618.8 8838.6 8956.8 8969.1 8971.1 8984.2 8719.5 8773.0 8823.7 8828.8 8839.1 8943.0 8988.9 9001.9 9012.1 9020.5 8904.6 8926.9 8944.7 8967.5 8978.7 8817.9 8970.1 8980.2 8998.7 9045.2 44011.0 44381.3 44402.8 44447.8 44454.3 3806.0 3841.6 3875.7 3878.4 4077.2 34445.5 34922.0 35003.3 35577.8 36822.0 4545.7 4558.8 4594.8 4651.6 4686.0 367496.0 368911.0 369199.0 370315.3 371184.0 64157.0 64170.7 64354.7 64458.0 64697.0 39736.2 40598.8 40601.0 41980.2 42353.6 17241.6 17330.1 17356.9 17449.8 17514.3 12969.3 13092.1 13135.8 13139.1 13146.1 21462.2 21733.3 21741.7 21868.2 21902.8 7301.3 7566.3 7570.4 7651.7 7950.7 1079.7 1113.8 1138.1 1195.4 1286.0 33957.5 33971.3 34208.7 34447.8 34470.0 1199.5 1214.2 1238.5 1295.4 1330.9 17446.4 17649.3 17679.1 17858.6 17957.3 167553.0 622711.0 640157.0 643092.0 1033171.0 67095.7 67286.3 67596.0 67680.3 67913.0 1468.3 1495.0 1524.4 1529.8 1539.3 33933.3 34300.3 34455.3 34508.5 34725.8 54676.5 55291.7 55448.4 55565.0 55586.7 525065.0 539487.0 540362.0 540808.0 540841.0 31137.8 31256.2 31376.0 31507.0 31577.4 52023.7 52941.5 53072.2 53167.7 53781.0 43072.6 43830.0 43918.0 44424.8 44719.8 43541.0 43715.0 44039.8 44503.6 44673.8 43702.3 44257.0 45556.8 45688.8 47804.8 40097.6 40163.4 40210.8 40670.4 40726.2 30264.7 30612.7 30645.2 30831.8 31374.2 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | [#2] jquery.html Cycles:180 Average:29100.97 Median:23910.70 stddev:79782.95 (333.7%) stddev-sans-first:79977.72 03:45:56 INFO - PROCESS | 8229 | Values: 432.5 433.1 433.5 435.8 440.5 18722.7 19829.2 19922.5 20538.0 20565.9 19110.0 19142.3 19359.3 19823.5 19843.9 5851.8 5987.4 5994.3 6018.8 6019.2 5851.9 5929.1 5947.4 5957.7 5958.4 5883.6 5890.4 5914.8 5922.4 5940.2 5610.6 5741.1 5883.6 5897.3 5917.4 5737.9 5740.8 5772.7 5782.7 5805.9 14869.0 16783.7 22561.0 23900.9 23920.5 2411.3 2431.3 2623.5 2960.4 3088.1 9777.8 10440.2 10455.4 10616.7 10931.7 1994.4 2030.4 2056.7 2086.7 2093.7 83773.0 86604.0 87831.6 88159.0 89247.6 10181.9 10496.9 10779.9 10797.9 10997.1 15052.7 15199.2 15201.7 15262.2 15298.7 7723.4 7906.8 7970.2 8112.0 8149.3 7793.3 7811.5 7837.0 7907.2 7918.8 4630.5 4705.4 4706.3 4761.5 4785.6 1992.4 2050.8 2061.7 2075.2 2112.8 928.9 979.0 1067.2 1103.7 1118.4 19325.9 19802.0 19882.0 19915.0 20180.7 1016.2 1027.7 1044.4 1060.4 1123.6 10673.3 11174.7 11332.9 11388.3 11397.5 471221.0 473430.0 485218.0 490722.0 494863.0 72045.9 91392.5 91652.0 92078.0 98883.0 1044.0 1052.1 1070.4 1089.9 1090.2 17875.4 17963.3 18167.5 18262.5 18304.2 41630.4 42181.2 42274.4 42866.8 43084.0 59851.4 59863.4 60223.0 61868.7 62399.4 9047.7 9170.5 9212.1 9226.9 9283.1 12370.2 13527.3 13691.2 13759.9 13773.4 11945.5 12000.9 12105.6 12123.5 12222.1 11174.1 11472.0 11839.3 12173.1 12334.0 11996.1 12138.2 12228.9 12361.9 12602.2 7923.1 8309.1 8963.5 9031.9 9432.6 10982.1 11956.1 12135.4 12202.8 12329.4 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | [#3] mootools.html Cycles:180 Average:6227.33 Median:2563.27 stddev:3621.57 (141.3%) stddev-sans-first:3614.54 03:45:56 INFO - PROCESS | 8229 | Values: 1531.1 1565.1 1792.7 1912.2 1942.0 8028.6 9113.2 9178.9 9823.3 9890.5 9160.3 9408.9 9459.1 9464.4 9562.4 2378.3 2385.0 2405.9 2409.3 2410.3 2396.7 2398.5 2419.7 2433.7 2438.8 2204.4 2212.6 2286.5 2421.6 2437.0 2299.2 2305.5 2324.9 2339.7 2342.5 2093.2 2097.5 2101.1 2111.5 2183.7 9410.8 9511.0 9515.8 9517.7 9525.1 5434.2 5536.6 5565.2 5590.2 5590.7 3385.5 3435.4 3465.4 3575.2 3601.5 1172.4 1184.5 1195.4 1206.8 1212.8 13205.1 13333.3 13394.5 13417.0 13527.4 4855.2 4888.8 4955.5 4981.3 5042.3 10678.2 10721.1 10745.2 10749.7 10809.7 5521.4 5585.8 5600.9 5615.5 5638.2 4645.6 5085.3 5093.1 5241.5 5255.0 4215.2 4256.1 4404.3 4416.0 4442.0 1322.5 1329.1 1333.4 1339.7 1361.8 1052.4 1053.9 1062.9 1065.0 1065.7 6173.6 6378.5 6433.1 6433.6 6458.6 480.9 491.1 491.2 491.9 497.0 4184.0 4194.6 4262.9 4284.2 4298.5 11708.8 11981.9 11983.6 12006.5 12013.6 11832.8 11859.5 11894.3 11929.5 11943.8 8617.3 8782.4 8862.9 9013.9 9203.4 6335.8 6463.9 6501.9 6509.7 6615.5 10367.2 10575.5 10598.4 10785.5 10836.0 10667.1 11182.2 11247.8 11354.8 11453.8 7442.7 8263.3 8434.9 8597.3 8713.3 9404.8 9408.2 9455.1 9467.4 9476.4 8299.5 8424.3 8545.1 8547.3 8641.4 8010.4 8137.8 8342.3 8422.2 8518.1 7757.2 7825.5 7895.7 7932.5 7939.0 5549.3 5596.4 5637.8 5782.5 5800.4 5789.9 5856.2 5864.5 5879.4 5969.5 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | [#4] prototype.html Cycles:180 Average:5130.53 Median:5825.33 stddev:1540.09 (26.4%) stddev-sans-first:1502.05 03:45:56 INFO - PROCESS | 8229 | Values: 351.0 351.2 352.0 354.9 358.8 5861.6 5885.8 5886.7 5888.7 5902.2 5788.2 5808.5 5842.2 5851.2 5876.9 4237.8 4404.3 4417.3 4430.7 4434.5 4373.5 4431.8 4432.6 4436.8 4463.0 4401.7 4421.6 4452.1 4489.7 4498.6 4239.3 4450.4 4474.1 4480.5 4507.2 3889.5 3903.7 3909.1 3918.1 3923.8 5666.7 5687.3 5692.3 5750.2 5766.4 4907.1 5148.9 5162.5 5183.6 5201.3 6110.9 6152.5 6154.4 6154.5 6155.2 4364.3 4366.8 4399.1 4399.2 4400.1 6106.0 6150.2 6309.5 6365.0 6370.5 4396.5 4397.8 4404.0 4406.7 4470.1 4501.2 4503.8 4510.2 4547.7 4575.4 4949.1 5183.2 5203.0 5209.8 5211.6 6072.0 6100.9 6119.2 6177.7 6183.4 1527.7 1554.3 1564.4 1566.7 1570.7 951.7 979.3 992.3 999.2 1005.5 5280.9 5368.2 5369.4 5386.4 5405.6 5563.9 5607.0 5609.6 5669.4 5681.9 5325.8 5340.5 5535.4 6017.7 6034.0 3371.7 3383.8 3386.2 3388.1 3398.6 6330.0 6489.4 6501.3 6521.3 6559.8 6499.6 6506.4 6518.7 6523.5 6539.4 6356.2 6537.3 6590.2 6604.8 6614.2 6356.5 6434.6 6437.8 6446.0 6467.6 6181.9 6196.9 6229.7 6282.5 6302.6 6575.2 6599.3 6611.3 6618.9 6620.4 4343.8 4402.8 4411.7 4416.9 4438.0 6248.3 6325.4 6415.2 6418.3 6438.7 6156.7 6209.7 6236.8 6246.5 6252.9 6016.8 6200.4 6202.8 6203.6 6247.5 6114.2 6121.6 6127.2 6134.9 6169.5 6314.6 6357.4 6361.4 6361.4 6371.9 5934.9 6110.6 6211.0 6216.6 6236.5 03:45:56 INFO - PROCESS | 8229 | 03:45:56 INFO - PROCESS | 8229 | [#5] yui.html Cycles:180 Average:21503.41 Median:4123.47 stddev:30537.43 (740.6%) stddev-sans-first:30583.44 03:45:56 INFO - PROCESS | 8229 | Values: 776.8 792.1 796.2 797.3 810.4 15579.5 16873.7 17011.2 17167.0 17188.6 15514.2 15683.1 15805.1 15811.3 15840.2 708.1 832.3 833.1 847.8 848.8 849.9 859.1 860.0 860.9 862.3 897.6 898.3 901.6 902.6 904.7 893.3 895.5 896.5 899.6 899.8 664.5 665.0 665.7 668.8 669.6 14842.8 14914.2 14948.3 15001.1 15030.5 15650.9 15942.5 16109.7 16158.4 16170.2 12361.9 12554.4 12595.2 12871.3 12885.5 4023.5 4105.7 4141.2 4155.1 4171.6 79800.6 81854.0 82628.2 82668.6 83335.0 11999.4 12219.3 12227.6 12273.3 12519.9 22214.8 22246.3 22282.4 22387.8 22486.0 8668.5 8959.9 9016.8 9134.1 9198.1 4940.6 4993.5 5055.7 5116.5 5154.2 3672.8 3827.8 3833.0 3836.7 3838.6 634.9 646.9 653.3 659.6 664.0 585.8 643.0 701.7 724.6 752.3 9945.3 10283.5 10396.9 10452.5 10608.8 667.9 671.8 672.7 684.6 697.7 4779.0 4802.0 4824.5 4853.6 4981.2 76078.2 122060.8 123443.0 123598.0 126381.0 70335.3 89977.6 91580.5 106367.0 107166.0 90980.1 95098.5 95827.5 96370.0 99066.0 9949.0 10125.7 10234.7 10407.9 10600.8 41508.6 53660.0 55189.7 56468.2 56671.7 69296.7 70941.3 71549.0 77486.2 81513.2 12895.7 13440.6 13519.3 13575.5 14258.0 14579.9 15201.0 15437.9 15813.9 16316.4 14601.5 14630.9 15057.2 15085.3 15203.2 14244.8 14523.8 14612.6 14725.9 14848.4 14738.9 15058.3 15302.9 15347.9 15380.3 11104.8 11480.4 11495.3 11629.5 11647.0 11433.8 12068.5 12264.4 12472.1 12541.0 03:45:56 INFO - PROCESS | 8229 | -------- Summary: end -------- 03:45:56 INFO - PROCESS | 8229 | 03:45:57 INFO - TEST-INFO | 8229: exit 0 03:45:57 INFO - TEST-OK | dromaeo_css | took 1110502ms 03:45:57 INFO - TEST-START | kraken 03:45:57 INFO - operating with platform_type : linux_ 03:45:57 INFO - Initialising browser for kraken test... 03:45:57 INFO - TEST-INFO | started process 8476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfvYPUB/profile http://localhost:48508/getInfo.html) 03:46:01 INFO - PROCESS | 8476 | __metrics Screen width/height:1600/1200 03:46:01 INFO - PROCESS | 8476 | colorDepth:24 03:46:01 INFO - PROCESS | 8476 | Browser inner width/height: 1024/697 03:46:01 INFO - PROCESS | 8476 | __metrics 03:46:02 ERROR - PROCESS | 8476 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 03:46:03 INFO - TEST-INFO | 8476: exit 0 03:46:03 INFO - Browser initialized. 03:46:03 INFO - Running cycle 1/1 for kraken test... 03:46:03 INFO - TEST-INFO | started process 8604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfvYPUB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:15 INFO - PROCESS | 8604 | RSS: Main: 156405760 03:46:15 INFO - PROCESS | 8604 | 03:46:17 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48508/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:18 INFO - PROCESS | 8604 | RSS: Main: 161370112 03:46:18 INFO - PROCESS | 8604 | 03:46:21 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48508/tests/kraken/driver.html?testName=audio-dft) 03:46:21 INFO - PROCESS | 8604 | RSS: Main: 160575488 03:46:21 INFO - PROCESS | 8604 | 03:46:24 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48508/tests/kraken/driver.html?testName=audio-fft) 03:46:25 INFO - PROCESS | 8604 | RSS: Main: 161640448 03:46:25 INFO - PROCESS | 8604 | 03:46:27 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48508/tests/kraken/driver.html?testName=audio-oscillator) 03:46:27 INFO - PROCESS | 8604 | RSS: Main: 161271808 03:46:27 INFO - PROCESS | 8604 | 03:46:30 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48508/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:30 INFO - PROCESS | 8604 | RSS: Main: 161263616 03:46:30 INFO - PROCESS | 8604 | 03:46:33 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48508/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:34 INFO - PROCESS | 8604 | RSS: Main: 161206272 03:46:34 INFO - PROCESS | 8604 | 03:46:37 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48508/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:38 INFO - PROCESS | 8604 | RSS: Main: 161808384 03:46:38 INFO - PROCESS | 8604 | 03:46:41 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48508/tests/kraken/driver.html?testName=json-parse-financial) 03:46:41 INFO - PROCESS | 8604 | RSS: Main: 161325056 03:46:41 INFO - PROCESS | 8604 | 03:46:43 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48508/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:43 INFO - PROCESS | 8604 | RSS: Main: 161636352 03:46:43 INFO - PROCESS | 8604 | 03:46:45 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:46 INFO - PROCESS | 8604 | RSS: Main: 161230848 03:46:46 INFO - PROCESS | 8604 | 03:46:48 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:49 INFO - PROCESS | 8604 | RSS: Main: 161869824 03:46:49 INFO - PROCESS | 8604 | 03:46:51 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:52 INFO - PROCESS | 8604 | RSS: Main: 161914880 03:46:52 INFO - PROCESS | 8604 | 03:46:54 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:55 INFO - PROCESS | 8604 | RSS: Main: 162050048 03:46:55 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | Cycle 1(1): loaded http://localhost:48508/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48508/tests/kraken/driver.html?testName=ai-astar) 03:46:57 INFO - PROCESS | 8604 | RSS: Main: 162553856 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | __start_tp_report 03:46:57 INFO - PROCESS | 8604 | _x_x_mozilla_page_load 03:46:57 INFO - PROCESS | 8604 | _x_x_mozilla_page_load_details 03:46:57 INFO - PROCESS | 8604 | |i|pagename|runs| 03:46:57 INFO - PROCESS | 8604 | |0;ai-astar;112;104;113;111;110;111;111;109;109;108 03:46:57 INFO - PROCESS | 8604 | |1;audio-beat-detection;162;123;151;180;126;163;158;136;182;127 03:46:57 INFO - PROCESS | 8604 | |2;audio-dft;163;162;162;162;162;162;163;165;162;162 03:46:57 INFO - PROCESS | 8604 | |3;audio-fft;75;76;77;169;75;75;75;76;169;75 03:46:57 INFO - PROCESS | 8604 | |4;audio-oscillator;84;84;155;84;84;84;132;84;85;153 03:46:57 INFO - PROCESS | 8604 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;118;117;117 03:46:57 INFO - PROCESS | 8604 | |6;imaging-darkroom;148;147;148;148;149;148;148;148;148;147 03:46:57 INFO - PROCESS | 8604 | |7;imaging-desaturate;96;96;97;94;96;95;95;96;95;95 03:46:57 INFO - PROCESS | 8604 | |8;json-parse-financial;53;52;53;53;52;54;57;55;56;54 03:46:57 INFO - PROCESS | 8604 | |9;json-stringify-tinderbox;60;59;59;59;59;59;60;59;59;59 03:46:57 INFO - PROCESS | 8604 | |10;stanford-crypto-aes;77;76;76;78;81;76;78;79;106;77 03:46:57 INFO - PROCESS | 8604 | |11;stanford-crypto-ccm;121;133;127;130;124;117;123;131;125;134 03:46:57 INFO - PROCESS | 8604 | |12;stanford-crypto-pbkdf2;157;154;161;159;153;154;154;151;155;156 03:46:57 INFO - PROCESS | 8604 | |13;stanford-crypto-sha256-iterative;62;63;63;63;66;62;62;63;61;61 03:46:57 INFO - PROCESS | 8604 | __end_tp_report 03:46:57 INFO - PROCESS | 8604 | __start_cc_report 03:46:57 INFO - PROCESS | 8604 | _x_x_mozilla_cycle_collect,866 03:46:57 INFO - PROCESS | 8604 | __end_cc_report 03:46:57 INFO - PROCESS | 8604 | __startTimestamp1465296417388__endTimestamp 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | ------- Summary: start ------- 03:46:57 INFO - PROCESS | 8604 | Number of tests: 14 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.53 (2.3%) stddev-sans-first:2.55 03:46:57 INFO - PROCESS | 8604 | Values: 112.0 104.0 113.0 111.0 110.0 111.0 111.0 109.0 109.0 108.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:160.00 stddev:21.92 (13.7%) stddev-sans-first:22.88 03:46:57 INFO - PROCESS | 8604 | Values: 162.0 123.0 151.0 180.0 126.0 163.0 158.0 136.0 182.0 127.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 03:46:57 INFO - PROCESS | 8604 | Values: 163.0 162.0 162.0 162.0 162.0 162.0 163.0 165.0 162.0 162.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:39.43 (52.6%) stddev-sans-first:41.20 03:46:57 INFO - PROCESS | 8604 | Values: 75.0 76.0 77.0 169.0 75.0 75.0 75.0 76.0 169.0 75.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:84.00 stddev:30.79 (36.7%) stddev-sans-first:31.89 03:46:57 INFO - PROCESS | 8604 | Values: 84.0 84.0 155.0 84.0 84.0 84.0 132.0 84.0 85.0 153.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:46:57 INFO - PROCESS | 8604 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:46:57 INFO - PROCESS | 8604 | Values: 148.0 147.0 148.0 148.0 149.0 148.0 148.0 148.0 148.0 147.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 03:46:57 INFO - PROCESS | 8604 | Values: 96.0 96.0 97.0 94.0 96.0 95.0 95.0 96.0 95.0 95.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.66 (3.1%) stddev-sans-first:1.73 03:46:57 INFO - PROCESS | 8604 | Values: 53.0 52.0 53.0 53.0 52.0 54.0 57.0 55.0 56.0 54.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 03:46:57 INFO - PROCESS | 8604 | Values: 60.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:77.50 stddev:9.13 (11.8%) stddev-sans-first:9.60 03:46:57 INFO - PROCESS | 8604 | Values: 77.0 76.0 76.0 78.0 81.0 76.0 78.0 79.0 106.0 77.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:128.50 stddev:5.50 (4.3%) stddev-sans-first:5.46 03:46:57 INFO - PROCESS | 8604 | Values: 121.0 133.0 127.0 130.0 124.0 117.0 123.0 131.0 125.0 134.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:155.50 stddev:2.95 (1.9%) stddev-sans-first:3.07 03:46:57 INFO - PROCESS | 8604 | Values: 157.0 154.0 161.0 159.0 153.0 154.0 154.0 151.0 155.0 156.0 03:46:57 INFO - PROCESS | 8604 | 03:46:57 INFO - PROCESS | 8604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.50 03:46:57 INFO - PROCESS | 8604 | Values: 62.0 63.0 63.0 63.0 66.0 62.0 62.0 63.0 61.0 61.0 03:46:57 INFO - PROCESS | 8604 | -------- Summary: end -------- 03:46:57 INFO - PROCESS | 8604 | 03:46:58 INFO - TEST-INFO | 8604: exit 0 03:46:58 INFO - TEST-OK | kraken | took 61306ms 03:46:58 INFO - SUITE-END | took 1171s 03:46:58 INFO - Completed test suite (00:19:32) 03:46:58 INFO - javascript benchmark 03:46:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7690.994642518902, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3389.7627166098378, 3404.5744281964753, 3411.1131105912455, 3444.8794292199777, 3455.6717111874364, 5701.03082475979, 5725.971370143148, 5802.5938184327115, 5834.533237341018, 5835.328937172227, 5762.366139724627, 5794.565407594437, 5865.999999999989, 5869.9706501467535, 5885.264341957255, 5208.661437006592, 5228.372595288571, 5261.710605916673, 5265.76304066318, 5288.365396152448, 5081.085404627165, 5109.310243117187, 5123.129068058421, 5305.920411193835, 5313.468653134694, 5200.3759548854005, 5209.400918894319, 5218.739063046852, 5220.686758794484, 5224.529792318691, 5250.107481728096, 5261.657992230493, 5274.630775845673, 5289.788408463657, 5326.83306165785, 5003.349564556621, 5173.405058418292, 5217.973910130425, 5267.789288428458, 5279.260903473517, 5518.696471694056, 5530.917036244459, 5616.354119276295, 5622.100463925753, 5625.774969001235, 6136.846578835565, 6165.630062196283, 6168.074788781674, 6199.473044791198, 6201.534884883652, 6227.470664993436, 6233.625982441068, 6236.594621349598, 6242.157308763304, 6268.0, 5731.083026715747, 5770.682612456313, 5797.710114494301, 5807.796727114573, 5842.707864606795, 6371.076193951851, 6389.840253993687, 6414.294427612959, 6423.5503514754455, 6429.8714025720155, 6063.393660633901, 6186.628802271788, 6190.535709821781, 6205.22434695663, 6205.2553693557065, 6057.273127224761, 6084.239470066242, 6090.299615544269, 6115.724792384264, 6151.179988745391, 6133.0, 6171.660558669227, 6184.6598437085495, 6188.690565471708, 6190.380961903774, 6078.817635470943, 6144.723487443076, 6161.691915404212, 6176.444120029129, 6185.938140618626, 4665.813367465331, 4677.111348843709, 4717.033008233304, 4740.762961851894, 4755.809767609326, 4222.59885310895, 4231.555686652857, 4234.364845273172, 4247.915041699211, 4261.765602891809, 5791.855203619859, 5811.535077193815, 6011.3086994995265, 6011.338752737195, 6032.125341825411, 6091.269047714302, 6111.865232675556, 6124.228368151176, 6197.907031394533, 6291.402316779899, 5931.733072011683, 5955.166276721263, 5964.701764911737, 5970.940290597126, 5985.191999080069, 5240.554552863049, 5240.71176085319, 5315.6279060465395, 5340.305760251143, 5360.624756267024, 6356.523260755369, 6436.388543088399, 6459.773907913201, 6471.0940468334475, 6492.0, 6223.190985171989, 6240.937590624036, 6241.032639940817, 6282.497400207881, 6287.96856015717, 6240.937590624036, 6280.685965701605, 6309.05364195356, 6466.805995820133, 6475.838104047248, 6112.437810945274, 6115.362036198588, 6124.320821494513, 6136.457808108435, 6136.764169924236, 6173.290071641819, 6244.65654389013, 6246.968765156145, 6251.9062214067735, 6260.561760676709, 5955.76176952917, 5998.640081595118, 6012.819615411545, 6052.606580572248, 6074.969625151846, 6033.728482218398, 6108.541859360655, 6120.17377654011, 6126.356732543197, 6130.172426722335, 5990.400959903975, 6026.0659597762415, 6031.24609423822, 6034.336223015553, 6046.606970546901, 6007.54943379257, 6041.18444010053, 6045.818625441244, 6113.23584551931, 6168.105624684305, 6009.278886533644, 6049.425304596057, 6050.546209034252, 6052.848678783065, 6062.666553339609], "value": 5711.505684284302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.3010092737323, 634.3086036220519, 663.5056882622443, 673.027475298194, 674.3256743256743, 41073.38389924153, 45683.0, 45838.541614583846, 45853.31220031698, 45876.54123458765, 47783.0, 48405.0, 48455.75772121135, 48510.27234591484, 48618.75690621542, 8838.5580720964, 8956.820863582725, 8969.058248883872, 8971.147740964598, 8984.19142277195, 8719.520426376546, 8773.03496615375, 8823.735287941372, 8828.779280517974, 8839.07189745077, 8942.955285223565, 8988.910110898873, 9001.909980900205, 9012.098790120968, 9020.503872287021, 8904.643814247422, 8926.86609700855, 8944.731658050268, 8967.506787126706, 8978.685745998891, 8817.867731984026, 8970.058143894928, 8980.191782739585, 8998.685046023424, 9045.231155351803, 44011.0, 44381.33995930413, 44402.77798611019, 44447.77776111131, 44454.33318500225, 3806.010437286298, 3841.5966323536186, 3875.6511913927884, 3878.3600705883496, 4077.245709543744, 34445.483317750004, 34922.0, 35003.299934001174, 35577.82211088928, 36822.0, 4545.659075569312, 4558.77206139695, 4594.770261486946, 4651.55810198034, 4685.953140468586, 367496.0, 368911.0, 369199.0, 370315.29684703075, 371183.9999999973, 64157.0, 64170.679146603965, 64354.678226608565, 64458.0, 64697.02954455687, 39736.2052758949, 40598.79700601478, 40601.0, 41980.16039679189, 42353.57646423558, 17241.56896077608, 17330.133493325535, 17356.91321543384, 17449.825501745076, 17514.299428022736, 12969.286689232184, 13092.083554151119, 13135.752103550147, 13139.080264381593, 13146.145500542625, 21462.24882129118, 21733.34799956004, 21741.67387489189, 21868.23461178883, 21902.780972190394, 7301.269873012762, 7566.281203285679, 7570.394368450511, 7651.732189373457, 7950.7217247396065, 1079.681493959284, 1113.7995160871121, 1138.0781566930812, 1195.384377045822, 1285.9614211573669, 33957.490637640454, 33971.32057358839, 34208.65791342105, 34447.82776086104, 34470.0, 1199.5321824488456, 1214.1864950483198, 1238.4674589926237, 1295.378218455147, 1330.9267990260628, 17446.38937637202, 17649.294028238983, 17679.05530391656, 17858.5535361617, 17957.281708731767, 167553.0, 622711.0, 640157.0, 643092.0, 1033171.0, 67095.66452167708, 67286.32713672899, 67596.0, 67680.32319676838, 67912.98130528047, 1468.2511918921214, 1494.9850501495064, 1524.3978628441703, 1529.8164220293413, 1539.3457780443266, 33933.32133357369, 34300.31399371949, 34455.31089378249, 34508.48237276493, 34725.82637086798, 54676.45323546714, 55291.72354138204, 55448.44551554433, 55565.0, 55586.72206639103, 525065.0, 539487.0, 540362.0, 540808.0, 540841.0, 31137.844310778302, 31256.21859453441, 31376.0, 31507.0, 31577.36845263128, 52023.73988130035, 52941.47058529365, 53072.203916942046, 53167.734161328946, 53781.0, 43072.56927430811, 43830.0, 43918.0, 44424.77787611041, 44719.77640111909, 43541.0, 43715.0, 44039.77980110079, 44503.55496444994, 44673.776631116634, 43702.344464832415, 44257.0, 45556.77221613871, 45688.771556142005, 47804.7609761949, 40097.59902401055, 40163.39754903737, 40210.79894600508, 40670.38994415027, 40726.1854762909, 30264.69735302619, 30612.693873060984, 30645.23386915345, 30831.84584077155, 31374.215644609067], "value": 21452.563079157335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.46374495625423, 433.1488624852165, 433.54477798311774, 435.8434505420989, 440.46483522520134, 18722.719159212607, 19829.206831726715, 19922.501937451572, 20538.0, 20565.897170514163, 19110.044497775125, 19142.330018449356, 19359.322423715173, 19823.5044123897, 19843.900780496115, 5851.79518716845, 5987.43119403656, 5994.340622531518, 6018.759249630009, 6019.187409699678, 5851.8537036574, 5929.110633404981, 5947.40525947404, 5957.731902064417, 5958.40415958405, 5883.558733095014, 5890.410958904118, 5914.792982245623, 5922.407759224065, 5940.2277703898435, 5610.635308704942, 5741.081426971686, 5883.61756485827, 5897.32180799205, 5917.378675239124, 5737.942620573825, 5740.82777516671, 5772.7113644317615, 5782.7108644568025, 5805.883882322372, 14869.0, 16783.66432671352, 22561.0, 23900.880495597412, 23920.521589568285, 2411.3248290478696, 2431.270618814366, 2623.5015347084186, 2960.3931194105157, 3088.104449709604, 9777.804443911082, 10440.164786817037, 10455.424951627658, 10616.681499555025, 10931.726706832313, 1994.3618042226494, 2030.4111807575784, 2056.650369437199, 2086.7182930304516, 2093.6859471079306, 83773.0, 86604.0, 87831.56084219538, 88159.0, 89247.55376223143, 10181.94909025465, 10496.947515262375, 10779.946100269448, 10797.892021079688, 10997.12023038155, 15052.698946021237, 15199.164045977357, 15201.695966080617, 15262.160581168142, 15298.694026119638, 7723.382129429632, 7906.841863162705, 7970.163132871081, 8111.9594402027615, 8149.348052155813, 7793.337566306927, 7811.4922530035365, 7836.960815195887, 7907.169747176578, 7918.841623167619, 4630.513796051433, 4705.364775755229, 4706.294055891643, 4761.476237613929, 4785.617150627942, 1992.3923203423094, 2050.7744148143693, 2061.711360409544, 2075.1803037799987, 2112.788721127906, 928.8792456980549, 978.9510524473748, 1067.2209287220373, 1103.6854496468468, 1118.4072441605963, 19325.90337048334, 19802.0, 19882.005899704956, 19915.0, 20180.697289540374, 1016.1870503597092, 1027.7225149209671, 1044.4464433849919, 1060.4273692206277, 1123.6292023632182, 10673.25287229902, 11174.66476005721, 11332.943335283271, 11388.316700997966, 11397.544098236143, 471221.0, 473430.0, 485218.0, 490722.0, 494863.0, 72045.91931121037, 91392.54303728438, 91652.0, 92078.0, 98883.01116988738, 1043.95824167034, 1052.1214785654065, 1070.4273213830718, 1089.9237053406343, 1090.2477290669572, 17875.37436189727, 17963.28146874163, 18167.545811354823, 18262.452126436227, 18304.176312066254, 41630.37554436747, 42181.1563768729, 42274.36588451237, 42866.78566607147, 43084.0, 59851.401485984585, 59863.40136598578, 60223.0, 61868.69065654643, 62399.376006241175, 9047.68333108338, 9170.495622740547, 9212.124848139416, 9226.907730922874, 9283.11810378013, 12370.195937264049, 13527.25600091965, 13691.178529288274, 13759.931200343934, 13773.380197890918, 11945.462454189408, 12000.879991199976, 12105.576304829288, 12123.515059397525, 12222.083343749076, 11174.106071514097, 11472.0, 11839.28964262147, 12173.147879648694, 12334.0, 11996.100292477924, 12138.211016283913, 12228.877711222774, 12361.93819030899, 12602.243865368107, 7923.128455869965, 8309.127541608044, 8963.507007114671, 9031.864522032043, 9432.575534101119, 10982.087585118827, 11956.103292252941, 12135.393230338625, 12202.75594488123, 12329.383530823603], "value": 9471.823133623864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.0966529747448, 1565.1235308227394, 1792.7042038063712, 1912.168206830028, 1941.9998700669157, 8028.558429286387, 9113.179813816756, 9178.86231706524, 9823.312368134233, 9890.456024918627, 9160.312976526771, 9408.905910940888, 9459.101385368396, 9464.384814987021, 9562.378445401062, 2378.3340664613893, 2384.988075059622, 2405.915792947247, 2409.325388891113, 2410.288964755401, 2396.700412448444, 2398.5322862041908, 2419.7096348438213, 2433.6592876997233, 2438.817088718344, 2204.40481070111, 2212.6017316882953, 2286.4741109544816, 2421.5641184586766, 2437.0, 2299.2297580310533, 2305.5043165719453, 2324.8840556532873, 2339.7192336919593, 2342.472943587696, 2093.2464312847364, 2097.528056187361, 2101.075526768217, 2111.4615772977945, 2183.661532462455, 9410.811783764355, 9511.048895110504, 9515.762105947337, 9517.714468565953, 9525.14273715362, 5434.157705555645, 5536.584756143265, 5565.220869078333, 5590.217369568264, 5590.692511911843, 3385.492176173569, 3435.3644575753315, 3465.358908601917, 3575.249197668493, 3601.4957905893198, 1172.4255114993678, 1184.5498710489958, 1195.4022988505747, 1206.8129439936824, 1212.8362671039474, 13205.07564470497, 13333.266670333127, 13394.464221431228, 13417.0, 13527.391267392892, 4855.223164293767, 4888.780004899788, 4955.529224723718, 4981.32752078472, 5042.294078828967, 10678.1991350649, 10721.142308615292, 10745.24783265164, 10749.677509674722, 10809.67570972872, 5521.4478552144465, 5585.804496842591, 5600.887982240414, 5615.522680572197, 5638.154276858504, 4645.628349732014, 5085.3134826797905, 5093.108705976513, 5241.475852414728, 5255.02781985334, 4215.220184265921, 4256.106217694319, 4404.295312749945, 4416.028473735773, 4442.0, 1322.451182759144, 1329.1360615599745, 1333.4266265505926, 1339.6583871112805, 1361.8297712785902, 1052.4422056310168, 1053.878803937557, 1062.930909490896, 1064.9680509584725, 1065.7388939709665, 6173.56785025044, 6378.457831084317, 6433.099366088752, 6433.646149461731, 6458.613309442114, 480.9206480930677, 491.09883364026695, 491.17972985114943, 491.86473719726644, 496.96878976124685, 4184.0, 4194.559571245037, 4262.87211383659, 4284.1645879053285, 4298.484181898192, 11708.824367634492, 11981.88018119825, 11983.64049078529, 12006.51973921051, 12013.579524716593, 11832.822507662391, 11859.525618975144, 11894.345810980307, 11929.463174157183, 11943.761124777457, 8617.267532259702, 8782.385233033754, 8862.911370886208, 9013.909860901307, 9203.355765096512, 6335.809925702236, 6463.870722585616, 6501.8699626008165, 6509.707063182263, 6615.470762339098, 10367.222458315808, 10575.524101415609, 10598.417087060287, 10785.514651840844, 10836.0, 10667.146628269564, 11182.161337899854, 11247.7750444989, 11354.829677554679, 11453.828192576952, 7442.665080071301, 8263.297619702393, 8434.873476897974, 8597.312215022908, 8713.259372953116, 9404.811903762024, 9408.247340212629, 9455.149036586465, 9467.431954082776, 9476.431414115175, 8299.460535065202, 8424.28393586552, 8545.102764209669, 8547.316214702932, 8641.351898607756, 8010.3992200584025, 8137.7965550859335, 8342.29090527312, 8422.199891010345, 8518.063013068682, 7757.224277572198, 7825.452218344662, 7895.7236496722335, 7932.484388514728, 7938.960305198437, 5549.278593782782, 5596.440355964371, 5637.830865074055, 5782.508486778671, 5800.39095894925, 5789.94210057894, 5856.238688970407, 5864.501517370901, 5879.441453061952, 5969.464811759424], "value": 4856.250316941059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9631488693687, 351.1589742566553, 351.96304388039255, 354.9493499242243, 358.75604588879554, 5861.589688721791, 5885.8234252972425, 5886.735096920638, 5888.704485013291, 5902.203202567652, 5788.2376455304075, 5808.477237048664, 5842.182094506772, 5851.15158302046, 5876.9118463223085, 4237.809298581564, 4404.317330813729, 4417.337399390101, 4430.667699922503, 4434.512203657611, 4373.540778218289, 4431.800568974388, 4432.623227025707, 4436.822527098912, 4462.977685111586, 4401.735895846244, 4421.646268298545, 4452.131834292314, 4489.730616163024, 4498.640108791289, 4239.258129827268, 4450.421445212134, 4474.105178964221, 4480.462344518646, 4507.233770259064, 3889.5414219667623, 3903.7072219583647, 3909.1009067914256, 3918.0792513759243, 3923.7645741255333, 5666.716664166775, 5687.26065611472, 5692.31692196939, 5750.223719797816, 5766.394528574481, 4907.11671899058, 5148.944466384382, 5162.483751624845, 5183.559397451221, 5201.271821944931, 6110.908336374958, 6152.507799376039, 6154.415330543591, 6154.476869466101, 6155.214987653575, 4364.323529852878, 4366.8471603494045, 4399.120175964787, 4399.23013472641, 4400.09797991411, 6106.0, 6150.169727086831, 6309.463695585835, 6365.013422919455, 6370.528062206109, 4396.494403143615, 4397.824087036547, 4403.9779801100785, 4406.691531592758, 4470.128324976663, 4501.212287849613, 4503.774811259424, 4510.21071312519, 4547.727136371828, 4575.359449677047, 4949.133901567211, 5183.248428977777, 5202.97398513005, 5209.765560549784, 5211.60912931524, 6071.969640151771, 6100.877982440326, 6119.164250724764, 6177.69111544421, 6183.381661833871, 1527.6791873706425, 1554.2927967774635, 1564.4368027510088, 1566.7074663402739, 1570.7251231034522, 951.70497145885, 979.294907666479, 992.265723364705, 999.160705007797, 1005.5374527717186, 5280.867978300496, 5368.1548779147115, 5369.40936496985, 5386.353637563439, 5405.621606487587, 5563.916541251884, 5607.018771714934, 5609.5792815539, 5669.376368599451, 5681.886362272731, 5325.813596524103, 5340.49265319794, 5535.418781028015, 6017.729202185912, 6033.969830150909, 3371.696547310754, 3383.796972181677, 3386.1873150443716, 3388.119089036868, 3398.6091599466376, 6329.968350158219, 6489.448396886318, 6501.284858665543, 6521.282658907517, 6559.770408035696, 6499.570094579185, 6506.41442270198, 6518.706658200393, 6523.510736694767, 6539.444147247537, 6356.205474315803, 6537.34626537352, 6590.176227971504, 6604.768833090819, 6614.173228346457, 6356.459700925473, 6434.648723768061, 6437.774677886251, 6446.0, 6467.611943283418, 6181.938180618136, 6196.907046394398, 6229.657368844757, 6282.465990390685, 6302.621842689453, 6575.178102737158, 6599.340065993362, 6611.33886611335, 6618.867622647616, 6620.3710647488415, 4343.782810859508, 4402.757848318373, 4411.691181617256, 4416.889577760582, 4437.977810110929, 6248.281447633581, 6325.367463253638, 6415.166028416276, 6418.293987661447, 6438.742450302123, 6156.692165391623, 6209.720562574605, 6236.812895613139, 6246.46905013079, 6252.937470625236, 6016.849578760566, 6200.3799620037635, 6202.81391558254, 6203.5731781689565, 6247.470179348654, 6114.2357205349335, 6121.632702037892, 6127.234095738033, 6134.938650613437, 6169.475594574512, 6314.5792196755365, 6357.376295511514, 6361.363863613602, 6361.395667411589, 6371.93628063732, 5934.940650593611, 6110.602810817282, 6211.0, 6216.601264715403, 6236.532260080421], "value": 4634.77928694631, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.7747353267551, 792.1484404265416, 796.2276591706051, 797.2744802229972, 810.4003037752061, 15579.454719084833, 16873.746893796604, 17011.234494447748, 17167.0, 17188.570285742862, 15514.224288785572, 15683.137427441514, 15805.051696898165, 15811.288492017859, 15840.20798960053, 708.1007120956382, 832.342449464922, 833.0794472108324, 847.8346722389136, 848.7793173774801, 849.8555245608261, 859.1108203009886, 859.9699010534632, 860.8880845490108, 862.3273846399818, 897.6050537763364, 898.2589363774879, 901.5672477210943, 902.5848109869468, 904.674317245791, 893.2942975049702, 895.5343221524803, 896.5472436419632, 899.6401439424217, 899.8245342158282, 664.5481072870447, 665.012456502094, 665.6738198282807, 668.759246671198, 669.5948950884693, 14842.777358339634, 14914.17972011539, 14948.252587370587, 15001.099934003994, 15030.473933412279, 15650.921745391313, 15942.521724348288, 16109.677806443922, 16158.353665853352, 16170.191490425432, 12361.876381236252, 12554.435050422753, 12595.225495971328, 12871.292078935654, 12885.549005784846, 4023.4769479967417, 4105.712600117993, 4141.233871733709, 4155.127423241123, 4171.645410140141, 79800.60099699523, 81854.0, 82628.17371826325, 82668.58665706693, 83335.0, 11999.400029998465, 12219.327936963553, 12227.638398203277, 12273.324967126715, 12519.93740031294, 22214.777852221596, 22246.332610021724, 22282.442938926655, 22387.776122238894, 22486.0, 8668.479891206547, 8959.865602015974, 9016.774580635405, 9134.132257435533, 9198.126178013077, 4940.604751619861, 4993.450720420751, 5055.721935293521, 5116.488351164854, 5154.201098829687, 3672.797996110186, 3827.8468861245237, 3833.041739565109, 3836.731428800013, 3838.5777564467885, 634.8857205703018, 646.8835609590319, 653.330336405179, 659.6042374575312, 664.0106241699832, 585.841822707875, 642.9614223146626, 701.719312275094, 724.6014691919529, 752.2890868129674, 9945.30382873192, 10283.485825708834, 10396.896031039592, 10452.477376131163, 10608.787824243625, 667.8731041102175, 671.7951024937344, 672.7309076369492, 684.6234570985938, 697.6755808549049, 4779.044191161782, 4801.95198048015, 4824.517548245148, 4853.587445067138, 4981.178105612606, 76078.23921760712, 122060.84347804563, 123443.0, 123598.0, 126381.0, 70335.2966470339, 89977.55011224902, 91580.54209729042, 106367.0, 107166.0, 90980.09019909849, 95098.52450737702, 95827.52086239663, 96370.0, 99066.0, 9948.950255248677, 10125.746856328651, 10234.744131396774, 10407.895921040692, 10600.787984240425, 41508.58491415047, 53660.0, 55189.72405137949, 56468.15297770619, 56671.716641416526, 69296.6535167341, 70941.29058709346, 71549.0, 77486.22513775015, 81513.18486815294, 12895.677608059874, 13440.596782096552, 13519.256440895451, 13575.52485662997, 14258.0, 14579.92710036443, 15201.0, 15437.922810385877, 15813.920930395274, 16316.428924988044, 14601.54139520095, 14630.926845366132, 15057.247137643293, 15085.321160548021, 15203.163825989235, 14244.786328205293, 14523.78214326807, 14612.561623151323, 14725.852741472449, 14848.40606375733, 14738.852611474176, 15058.32237549291, 15302.923485382502, 15347.923260383626, 15380.307886145374, 11104.833427498432, 11480.368579728196, 11495.310281383145, 11629.476673549541, 11647.0, 11433.824442843234, 12068.500404648012, 12264.38678066111, 12472.126951113698, 12541.0], "value": 7922.464144740607, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 113.0, 111.0, 110.0, 111.0, 111.0, 109.0, 109.0, 108.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 123.0, 151.0, 180.0, 126.0, 163.0, 158.0, 136.0, 182.0, 127.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 165.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 169.0, 75.0, 75.0, 75.0, 76.0, 169.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 84.0, 84.0, 84.0, 132.0, 84.0, 85.0, 153.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 94.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 52.0, 54.0, 57.0, 55.0, 56.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 78.0, 81.0, 76.0, 78.0, 79.0, 106.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 133.0, 127.0, 130.0, 124.0, 117.0, 123.0, 131.0, 125.0, 134.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 161.0, 159.0, 153.0, 154.0, 154.0, 151.0, 155.0, 156.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 66.0, 62.0, 62.0, 63.0, 61.0, 61.0], "value": 62.6, "unit": "score"}]}]} 03:46:58 INFO - Return code: 0 03:46:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:58 ERROR - # TBPL SUCCESS # 03:46:58 INFO - Running post-action listener: _resource_record_post_action 03:46:58 INFO - ##### 03:46:58 INFO - ##### Finished run-tests step (success) 03:46:58 INFO - ##### 03:46:58 INFO - Running post-run listener: _resource_record_post_run 03:46:58 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510431232; Read time: 20; Write time: 539168 03:46:58 INFO - TinderboxPrint: CPU usage
13.4% 03:46:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:46:58 INFO - TinderboxPrint: I/O write bytes / time
510,431,232 / 539,168 03:46:58 INFO - TinderboxPrint: CPU idle
8,215.1 (86.6%) 03:46:58 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 03:46:58 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:58 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259252224; Read time: 0; Write time: 336948 03:46:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251179008; Read time: 20; Write time: 202220 03:46:59 INFO - Running post-run listener: _upload_blobber_files 03:46:59 INFO - Blob upload gear active. 03:46:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:59 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 03:46:59 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:46:59 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:46:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:00 INFO - (blobuploader) - INFO - Done attempting. 03:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:01 INFO - (blobuploader) - INFO - Done attempting. 03:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:05 INFO - (blobuploader) - INFO - Done attempting. 03:47:05 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:05 INFO - Return code: 0 03:47:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9b30596211513604cdd422e5e5c658921c55f23d5adb072387144f4fc7ce8ac58c9d6605e6f9403f81f916b6709cf9411d67078e6a4dbf087817d8418ffd5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab5f1a60d0e9ee7ceb5e7cc3bc6f4af068d1d40524093b157713f368dbb6e58f1adf0a0d89d7b07b9e3d4a53975c2926c8907eb4ac068c1b4a61e25f7e8d0e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a2b4851dc55a1498897b5e9deb0d30f392d46a2eecc6e75613b70ce5b4f75a2688b65dd4c2f51eda53ca121431983dd0b0facf1e130ab6eeb7acc8be74f9b8c"} 03:47:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:05 INFO - Contents: 03:47:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9b30596211513604cdd422e5e5c658921c55f23d5adb072387144f4fc7ce8ac58c9d6605e6f9403f81f916b6709cf9411d67078e6a4dbf087817d8418ffd5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab5f1a60d0e9ee7ceb5e7cc3bc6f4af068d1d40524093b157713f368dbb6e58f1adf0a0d89d7b07b9e3d4a53975c2926c8907eb4ac068c1b4a61e25f7e8d0e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a2b4851dc55a1498897b5e9deb0d30f392d46a2eecc6e75613b70ce5b4f75a2688b65dd4c2f51eda53ca121431983dd0b0facf1e130ab6eeb7acc8be74f9b8c"} 03:47:05 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:05 INFO - Copying logs to upload dir... 03:47:05 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.639982 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-07 03:47:05.283940) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 03:47:05.287908) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9b30596211513604cdd422e5e5c658921c55f23d5adb072387144f4fc7ce8ac58c9d6605e6f9403f81f916b6709cf9411d67078e6a4dbf087817d8418ffd5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab5f1a60d0e9ee7ceb5e7cc3bc6f4af068d1d40524093b157713f368dbb6e58f1adf0a0d89d7b07b9e3d4a53975c2926c8907eb4ac068c1b4a61e25f7e8d0e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a2b4851dc55a1498897b5e9deb0d30f392d46a2eecc6e75613b70ce5b4f75a2688b65dd4c2f51eda53ca121431983dd0b0facf1e130ab6eeb7acc8be74f9b8c"} build_url:https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/TcY3ioAWT9-22QS6B8_Cqg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9b30596211513604cdd422e5e5c658921c55f23d5adb072387144f4fc7ce8ac58c9d6605e6f9403f81f916b6709cf9411d67078e6a4dbf087817d8418ffd5d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab5f1a60d0e9ee7ceb5e7cc3bc6f4af068d1d40524093b157713f368dbb6e58f1adf0a0d89d7b07b9e3d4a53975c2926c8907eb4ac068c1b4a61e25f7e8d0e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a2b4851dc55a1498897b5e9deb0d30f392d46a2eecc6e75613b70ce5b4f75a2688b65dd4c2f51eda53ca121431983dd0b0facf1e130ab6eeb7acc8be74f9b8c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 03:47:05.313231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:47:05.313625) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1465295190.192913-286796739 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:47:05.397685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 03:47:05.398022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 03:47:05.398344) ========= ========= Total master_lag: 0.18 =========