builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1464240155.28 results: success (0) buildid: 20160525194948 builduid: 4cbf067958764ac196bcd4a921191ebd revision: 7c3ef5d06736bc63d138975a7194050569c62636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.279299) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.280030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.280529) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.296620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.297258) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 22:22:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.5M=0s 2016-05-25 22:22:35 (89.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.425913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.426242) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020057 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:35.477141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 22:22:35.477537) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7c3ef5d06736bc63d138975a7194050569c62636 --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-beta --rev 7c3ef5d06736bc63d138975a7194050569c62636 --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=edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 22:22:35,637 truncating revision to first 12 chars 2016-05-25 22:22:35,637 Setting DEBUG logging. 2016-05-25 22:22:35,637 attempt 1/10 2016-05-25 22:22:35,637 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7c3ef5d06736?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 22:22:37,013 unpacking tar archive at: mozilla-beta-7c3ef5d06736/testing/mozharness/ program finished with exit code 0 elapsedTime=1.718698 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-25 22:22:37.210396) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:37.210746) ========= script_repo_revision: 7c3ef5d06736bc63d138975a7194050569c62636 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:37.211136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:37.211410) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 22:22:37.222283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-25 22:22:37.222574) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:22:37 INFO - MultiFileLogger online at 20160525 22:22:37 in /builds/slave/test 22:22:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:22:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:22:37 INFO - {'append_to_log': False, 22:22:37 INFO - 'base_work_dir': '/builds/slave/test', 22:22:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:22:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:22:37 INFO - 'branch': 'Mozilla-Beta', 22:22:37 INFO - 'buildbot_json_path': 'buildprops.json', 22:22:37 INFO - 'config_files': ('talos/linux_config.py',), 22:22:37 INFO - 'default_actions': ('clobber', 22:22:37 INFO - 'read-buildbot-config', 22:22:37 INFO - 'download-and-extract', 22:22:37 INFO - 'populate-webroot', 22:22:37 INFO - 'create-virtualenv', 22:22:37 INFO - 'install', 22:22:37 INFO - 'run-tests'), 22:22:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:22:37 INFO - 'download_minidump_stackwalk': True, 22:22:37 INFO - 'download_symbols': 'ondemand', 22:22:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:22:37 INFO - 'tooltool.py': '/tools/tooltool.py', 22:22:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:22:37 INFO - '/tools/misc-python/virtualenv.py')}, 22:22:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:22:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:22:37 INFO - 'installer_path': 'installer.exe', 22:22:37 INFO - 'log_level': 'info', 22:22:37 INFO - 'log_name': 'talos', 22:22:37 INFO - 'log_to_console': True, 22:22:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:22:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:22:37 INFO - 'opt_config_files': (), 22:22:37 INFO - 'pip_index': False, 22:22:37 INFO - 'sps_profile': False, 22:22:37 INFO - 'sps_profile_interval': 0, 22:22:37 INFO - 'suite': 'dromaeojs-e10s', 22:22:37 INFO - 'system_bits': '32', 22:22:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:22:37 INFO - 'title': 'talos-linux64-ix-033', 22:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:22:37 INFO - 'use_talos_json': True, 22:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:22:37 INFO - 'work_dir': 'build'} 22:22:37 INFO - ##### 22:22:37 INFO - ##### Running clobber step. 22:22:37 INFO - ##### 22:22:37 INFO - Running pre-action listener: _resource_record_pre_action 22:22:37 INFO - Running main action method: clobber 22:22:37 INFO - rmtree: /builds/slave/test/build 22:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:22:37 INFO - Running post-action listener: _resource_record_post_action 22:22:37 INFO - ##### 22:22:37 INFO - ##### Running read-buildbot-config step. 22:22:37 INFO - ##### 22:22:37 INFO - Running pre-action listener: _resource_record_pre_action 22:22:37 INFO - Running main action method: read_buildbot_config 22:22:37 INFO - Using buildbot properties: 22:22:37 INFO - { 22:22:37 INFO - "project": "", 22:22:37 INFO - "product": "firefox", 22:22:37 INFO - "script_repo_revision": "production", 22:22:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 22:22:37 INFO - "repository": "", 22:22:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 22:22:37 INFO - "buildid": "20160525194948", 22:22:37 INFO - "pgo_build": "True", 22:22:37 INFO - "basedir": "/builds/slave/test", 22:22:37 INFO - "buildnumber": 122, 22:22:37 INFO - "slavename": "talos-linux64-ix-033", 22:22:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:22:37 INFO - "platform": "ubuntu64_hw", 22:22:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:22:37 INFO - "branch": "mozilla-beta", 22:22:37 INFO - "repo_path": "releases/mozilla-beta", 22:22:37 INFO - "revision": "7c3ef5d06736bc63d138975a7194050569c62636", 22:22:37 INFO - "stage_platform": "linux64-pgo", 22:22:37 INFO - "builduid": "4cbf067958764ac196bcd4a921191ebd", 22:22:37 INFO - "slavebuilddir": "test" 22:22:37 INFO - } 22:22:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 22:22:37 INFO - Running post-action listener: _resource_record_post_action 22:22:37 INFO - ##### 22:22:37 INFO - ##### Running download-and-extract step. 22:22:37 INFO - ##### 22:22:37 INFO - Running pre-action listener: _resource_record_pre_action 22:22:37 INFO - Running main action method: download_and_extract 22:22:37 INFO - mkdir: /builds/slave/test/build/tests 22:22: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')]} 22:22:37 INFO - https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:22:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:22:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:22:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:22:39 INFO - Downloaded 1412 bytes. 22:22:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:22:39 INFO - Using the following test package requirements: 22:22:39 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 22:22:39 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:22:39 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 22:22:39 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'jsshell-linux-x86_64.zip'], 22:22:39 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:22:39 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 22:22:39 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 22:22:39 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 22:22:39 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:22:39 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 22:22:39 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:22:39 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:22:39 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:39 INFO - https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:22:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:22:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:22:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:40 INFO - Downloaded 23434512 bytes. 22:22:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:22:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:22:41 INFO - Return code: 0 22:22:41 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:22:41 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')]} 22:22:41 INFO - https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:22:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:22:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:22:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:22:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:51 INFO - Downloaded 23434512 bytes. 22:22:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:22:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:22:53 INFO - Return code: 0 22:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:53 INFO - https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:22:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 22:22:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 22:22:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 22:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:22:54 INFO - Downloaded 10845194 bytes. 22:22:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:22:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:22:54 INFO - Return code: 0 22:22:54 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')]} 22:22:54 INFO - https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:22:55 INFO - Downloaded 53849309 bytes. 22:22:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:22:55 INFO - mkdir: /builds/slave/test/properties 22:22:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:22:55 INFO - Writing to file /builds/slave/test/properties/build_url 22:22:55 INFO - Contents: 22:22:55 INFO - build_url:https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:22:56 INFO - Running post-action listener: _resource_record_post_action 22:22:56 INFO - Running post-action listener: set_extra_try_arguments 22:22:56 INFO - ##### 22:22:56 INFO - ##### Running populate-webroot step. 22:22:56 INFO - ##### 22:22:56 INFO - Running pre-action listener: _resource_record_pre_action 22:22:56 INFO - Running main action method: populate_webroot 22:22:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:22:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:22:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:22:56 INFO - '--tppagecycles', 22:22:56 INFO - '7'], 22:22:56 INFO - 'tests': ['tsvgm']}}, 22:22:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:22:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:22:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:22:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:22:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'tests': ['damp', 'tps']}, 22:22:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['damp', 'tps']}, 22:22:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:22:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:22:56 INFO - 'other': {'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other_l64': {'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'other_nol64': {'tests': ['a11yr', 22:22:56 INFO - 'ts_paint', 22:22:56 INFO - 'tpaint', 22:22:56 INFO - 'sessionrestore', 22:22:56 INFO - 'sessionrestore_no_auto_restore', 22:22:56 INFO - 'tabpaint']}, 22:22:56 INFO - 'svgr': {'tests': ['tsvgx', 22:22:56 INFO - 'tsvgr_opacity', 22:22:56 INFO - 'tart', 22:22:56 INFO - 'tscrollx', 22:22:56 INFO - 'cart']}, 22:22:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['tsvgx', 22:22:56 INFO - 'tsvgr_opacity', 22:22:56 INFO - 'tart', 22:22:56 INFO - 'tscrollx', 22:22:56 INFO - 'cart']}, 22:22:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'tests': ['tp5o']}, 22:22:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--e10s'], 22:22:56 INFO - 'tests': ['tp5o']}, 22:22:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--xperf_path', 22:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:56 INFO - 'tests': ['tp5n']}, 22:22:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:56 INFO - 'talos_options': ['--e10s', 22:22:56 INFO - '--xperf_path', 22:22:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:56 INFO - 'tests': ['tp5n']}}, 22:22:56 INFO - 'talos.zip': {'path': '', 22:22:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:22:56 INFO - Running post-action listener: _resource_record_post_action 22:22:56 INFO - ##### 22:22:56 INFO - ##### Running create-virtualenv step. 22:22:56 INFO - ##### 22:22:56 INFO - Running pre-action listener: _resource_record_pre_action 22:22:56 INFO - Running main action method: create_virtualenv 22:22:56 INFO - Creating virtualenv /builds/slave/test/build/venv 22:22:56 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 22:22:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:22:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:22:56 INFO - Using real prefix '/usr' 22:22:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:22:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:22:59 INFO - Installing pip.................done. 22:22:59 INFO - Return code: 0 22:22:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 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 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:22:59 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 22:22:59 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 22:22:59 INFO - Using env: {'DISPLAY': ':0', 22:22:59 INFO - 'HOME': '/home/cltbld', 22:22:59 INFO - 'LANG': 'en_US.UTF-8', 22:22:59 INFO - 'LANGUAGE': 'en_US:en', 22:22:59 INFO - 'LOGNAME': 'cltbld', 22:22:59 INFO - 'MAIL': '/var/mail/cltbld', 22:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:59 INFO - 'MOZ_NO_REMOTE': '1', 22:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:59 INFO - 'NO_EM_RESTART': '1', 22:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:59 INFO - 'PWD': '/builds/slave/test', 22:22:59 INFO - 'SHELL': '/bin/bash', 22:22:59 INFO - 'SHLVL': '1', 22:22:59 INFO - 'TERM': 'linux', 22:22:59 INFO - 'TMOUT': '86400', 22:22:59 INFO - 'USER': 'cltbld', 22:22:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:59 INFO - '_': '/tools/buildbot/bin/python'} 22:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:59 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 22:22:59 INFO - Cleaning up... 22:22:59 INFO - Return code: 0 22:22:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:59 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:22:59 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>=0.7.1'] in /builds/slave/test/build 22:22:59 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>=0.7.1 22:22:59 INFO - Using env: {'DISPLAY': ':0', 22:22:59 INFO - 'HOME': '/home/cltbld', 22:22:59 INFO - 'LANG': 'en_US.UTF-8', 22:22:59 INFO - 'LANGUAGE': 'en_US:en', 22:22:59 INFO - 'LOGNAME': 'cltbld', 22:22:59 INFO - 'MAIL': '/var/mail/cltbld', 22:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:59 INFO - 'MOZ_NO_REMOTE': '1', 22:22:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:59 INFO - 'NO_EM_RESTART': '1', 22:22:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:59 INFO - 'PWD': '/builds/slave/test', 22:22:59 INFO - 'SHELL': '/bin/bash', 22:22:59 INFO - 'SHLVL': '1', 22:22:59 INFO - 'TERM': 'linux', 22:22:59 INFO - 'TMOUT': '86400', 22:22:59 INFO - 'USER': 'cltbld', 22:22:59 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:59 INFO - '_': '/tools/buildbot/bin/python'} 22:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:59 INFO - Downloading/unpacking psutil>=0.7.1 22:22:59 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 22:22:59 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 22:22:59 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 22:22:59 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 22:22:59 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 22:22:59 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 22:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:23:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:01 INFO - Installing collected packages: psutil 22:23:01 INFO - Running setup.py install for psutil 22:23:01 INFO - building 'psutil._psutil_linux' extension 22:23:01 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 22:23:01 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 22:23:01 INFO - building 'psutil._psutil_posix' extension 22:23:01 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 22:23:01 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 22:23:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:02 INFO - Successfully installed psutil 22:23:02 INFO - Cleaning up... 22:23:02 INFO - Return code: 0 22:23:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:02 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:23:02 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.0.0'] in /builds/slave/test/build 22:23:02 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.0.0 22:23:02 INFO - Using env: {'DISPLAY': ':0', 22:23:02 INFO - 'HOME': '/home/cltbld', 22:23:02 INFO - 'LANG': 'en_US.UTF-8', 22:23:02 INFO - 'LANGUAGE': 'en_US:en', 22:23:02 INFO - 'LOGNAME': 'cltbld', 22:23:02 INFO - 'MAIL': '/var/mail/cltbld', 22:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:02 INFO - 'MOZ_NO_REMOTE': '1', 22:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:02 INFO - 'NO_EM_RESTART': '1', 22:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:02 INFO - 'PWD': '/builds/slave/test', 22:23:02 INFO - 'SHELL': '/bin/bash', 22:23:02 INFO - 'SHLVL': '1', 22:23:02 INFO - 'TERM': 'linux', 22:23:02 INFO - 'TMOUT': '86400', 22:23:02 INFO - 'USER': 'cltbld', 22:23:02 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:02 INFO - '_': '/tools/buildbot/bin/python'} 22:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:23:02 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 22:23:02 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 22:23:02 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 22:23:02 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 22:23:02 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 22:23:02 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 22:23:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:23:04 INFO - Installing collected packages: mozsystemmonitor 22:23:04 INFO - Running setup.py install for mozsystemmonitor 22:23:04 INFO - Successfully installed mozsystemmonitor 22:23:04 INFO - Cleaning up... 22:23:04 INFO - Return code: 0 22:23:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:23:04 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')]} 22:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:04 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')]} 22:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:04 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 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:23:04 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 22:23:04 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 22:23:04 INFO - Using env: {'DISPLAY': ':0', 22:23:04 INFO - 'HOME': '/home/cltbld', 22:23:04 INFO - 'LANG': 'en_US.UTF-8', 22:23:04 INFO - 'LANGUAGE': 'en_US:en', 22:23:04 INFO - 'LOGNAME': 'cltbld', 22:23:04 INFO - 'MAIL': '/var/mail/cltbld', 22:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:04 INFO - 'MOZ_NO_REMOTE': '1', 22:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:04 INFO - 'NO_EM_RESTART': '1', 22:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:04 INFO - 'PWD': '/builds/slave/test', 22:23:04 INFO - 'SHELL': '/bin/bash', 22:23:04 INFO - 'SHLVL': '1', 22:23:04 INFO - 'TERM': 'linux', 22:23:04 INFO - 'TMOUT': '86400', 22:23:04 INFO - 'USER': 'cltbld', 22:23:04 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:04 INFO - '_': '/tools/buildbot/bin/python'} 22:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:04 INFO - Downloading/unpacking blobuploader==1.2.4 22:23:04 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 22:23:04 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 22:23:04 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 22:23:04 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 22:23:04 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 22:23:04 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 22:23:06 INFO - Downloading blobuploader-1.2.4.tar.gz 22:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:23:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:23:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23:07 INFO - Downloading docopt-0.6.1.tar.gz 22:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:23:07 INFO - Installing collected packages: blobuploader, requests, docopt 22:23:07 INFO - Running setup.py install for blobuploader 22:23:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:23:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:23:07 INFO - Running setup.py install for requests 22:23:07 INFO - Running setup.py install for docopt 22:23:07 INFO - Successfully installed blobuploader requests docopt 22:23:07 INFO - Cleaning up... 22:23:07 INFO - Return code: 0 22:23:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:07 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 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:23:07 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 22:23:07 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 22:23:07 INFO - Using env: {'DISPLAY': ':0', 22:23:07 INFO - 'HOME': '/home/cltbld', 22:23:07 INFO - 'LANG': 'en_US.UTF-8', 22:23:07 INFO - 'LANGUAGE': 'en_US:en', 22:23:07 INFO - 'LOGNAME': 'cltbld', 22:23:07 INFO - 'MAIL': '/var/mail/cltbld', 22:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:07 INFO - 'MOZ_NO_REMOTE': '1', 22:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:07 INFO - 'NO_EM_RESTART': '1', 22:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:07 INFO - 'PWD': '/builds/slave/test', 22:23:07 INFO - 'SHELL': '/bin/bash', 22:23:07 INFO - 'SHLVL': '1', 22:23:07 INFO - 'TERM': 'linux', 22:23:07 INFO - 'TMOUT': '86400', 22:23:07 INFO - 'USER': 'cltbld', 22:23:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:07 INFO - '_': '/tools/buildbot/bin/python'} 22:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:23:08 INFO - Running setup.py (path:/tmp/pip-1L9vcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:23:08 INFO - Running setup.py (path:/tmp/pip-WW09l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:23:08 INFO - Running setup.py (path:/tmp/pip-nz4bDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:23:08 INFO - Running setup.py (path:/tmp/pip-_rsJpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:23:08 INFO - Running setup.py (path:/tmp/pip-BfGc4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:23:08 INFO - Running setup.py (path:/tmp/pip-3jYhet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:23:08 INFO - Running setup.py (path:/tmp/pip-SFwvpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:23:08 INFO - Running setup.py (path:/tmp/pip-8gobiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:23:08 INFO - Running setup.py (path:/tmp/pip-o7Oadl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:23:08 INFO - Running setup.py (path:/tmp/pip-fb47sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:23:08 INFO - Running setup.py (path:/tmp/pip-kDUNs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:23:08 INFO - Running setup.py (path:/tmp/pip-deBKvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:23:08 INFO - Running setup.py (path:/tmp/pip-v_syFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:23:09 INFO - Running setup.py (path:/tmp/pip-3zfTHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:09 INFO - Running setup.py (path:/tmp/pip-QkTeD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:23:09 INFO - Running setup.py (path:/tmp/pip-BaPxG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:23:09 INFO - Running setup.py (path:/tmp/pip-qdLPlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:23:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:23:09 INFO - Running setup.py install for manifestparser 22:23:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:23:09 INFO - Running setup.py install for mozcrash 22:23:09 INFO - Running setup.py install for mozdebug 22:23:09 INFO - Running setup.py install for mozdevice 22:23:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:23:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:23:09 INFO - Running setup.py install for mozfile 22:23:09 INFO - Running setup.py install for mozhttpd 22:23:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:23:09 INFO - Running setup.py install for mozinfo 22:23:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozInstall 22:23:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozleak 22:23:10 INFO - Running setup.py install for mozlog 22:23:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for moznetwork 22:23:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozprocess 22:23:10 INFO - Running setup.py install for mozprofile 22:23:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozrunner 22:23:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:23:10 INFO - Running setup.py install for mozscreenshot 22:23:10 INFO - Running setup.py install for moztest 22:23:10 INFO - Running setup.py install for mozversion 22:23:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:23:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:23:11 INFO - Cleaning up... 22:23:11 INFO - Return code: 0 22:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:11 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 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:23:11 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 22:23:11 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 22:23:11 INFO - Using env: {'DISPLAY': ':0', 22:23:11 INFO - 'HOME': '/home/cltbld', 22:23:11 INFO - 'LANG': 'en_US.UTF-8', 22:23:11 INFO - 'LANGUAGE': 'en_US:en', 22:23:11 INFO - 'LOGNAME': 'cltbld', 22:23:11 INFO - 'MAIL': '/var/mail/cltbld', 22:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:11 INFO - 'MOZ_NO_REMOTE': '1', 22:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:11 INFO - 'NO_EM_RESTART': '1', 22:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:11 INFO - 'PWD': '/builds/slave/test', 22:23:11 INFO - 'SHELL': '/bin/bash', 22:23:11 INFO - 'SHLVL': '1', 22:23:11 INFO - 'TERM': 'linux', 22:23:11 INFO - 'TMOUT': '86400', 22:23:11 INFO - 'USER': 'cltbld', 22:23:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:11 INFO - '_': '/tools/buildbot/bin/python'} 22:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:23:11 INFO - Running setup.py (path:/tmp/pip-BB6q25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:23:11 INFO - Running setup.py (path:/tmp/pip-JKRcLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:23:11 INFO - Running setup.py (path:/tmp/pip-NByVEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:23:11 INFO - Running setup.py (path:/tmp/pip-GKRHL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:23:11 INFO - Running setup.py (path:/tmp/pip-rNm3zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:23:11 INFO - Running setup.py (path:/tmp/pip-VUErfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:23:11 INFO - Running setup.py (path:/tmp/pip-bfgoun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:23:11 INFO - Running setup.py (path:/tmp/pip-DGKT43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:23:11 INFO - Running setup.py (path:/tmp/pip-sbpqFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:23:11 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)) 22:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:23:11 INFO - Running setup.py (path:/tmp/pip-O7x30m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:23:12 INFO - Running setup.py (path:/tmp/pip-meRmOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:23:12 INFO - Running setup.py (path:/tmp/pip-tcuWlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:23:12 INFO - Running setup.py (path:/tmp/pip-1HZ4XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:23:12 INFO - Running setup.py (path:/tmp/pip-6N41Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:12 INFO - Running setup.py (path:/tmp/pip-_5ouVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:23:12 INFO - Running setup.py (path:/tmp/pip-3wBX5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:23:12 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)) 22:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:23:12 INFO - Running setup.py (path:/tmp/pip-FOiO4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:23:12 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)) 22:23:12 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)) 22:23:12 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)) 22:23:12 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)) 22:23:12 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)) 22:23:12 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)) 22:23:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:14 INFO - Downloading blessings-1.6.tar.gz 22:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:23:14 INFO - Installing collected packages: blessings 22:23:14 INFO - Running setup.py install for blessings 22:23:14 INFO - Successfully installed blessings 22:23:14 INFO - Cleaning up... 22:23:14 INFO - Return code: 0 22:23:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:23:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:23:14 INFO - Reading from file tmpfile_stdout 22:23:14 INFO - Current package versions: 22:23:14 INFO - argparse == 1.2.1 22:23:14 INFO - blessings == 1.6 22:23:14 INFO - blobuploader == 1.2.4 22:23:14 INFO - docopt == 0.6.1 22:23:14 INFO - manifestparser == 1.1 22:23:14 INFO - mozInstall == 1.12 22:23:14 INFO - mozcrash == 0.17 22:23:14 INFO - mozdebug == 0.1 22:23:14 INFO - mozdevice == 0.48 22:23:14 INFO - mozfile == 1.2 22:23:14 INFO - mozhttpd == 0.7 22:23:14 INFO - mozinfo == 0.9 22:23:14 INFO - mozleak == 0.1 22:23:14 INFO - mozlog == 3.1 22:23:14 INFO - moznetwork == 0.27 22:23:14 INFO - mozprocess == 0.22 22:23:14 INFO - mozprofile == 0.28 22:23:14 INFO - mozrunner == 6.11 22:23:14 INFO - mozscreenshot == 0.1 22:23:14 INFO - mozsystemmonitor == 0.0 22:23:14 INFO - moztest == 0.7 22:23:14 INFO - mozversion == 1.4 22:23:14 INFO - psutil == 3.1.1 22:23:14 INFO - requests == 1.2.3 22:23:14 INFO - wsgiref == 0.1.2 22:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:14 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 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:23:14 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 22:23:14 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 22:23:14 INFO - Using env: {'DISPLAY': ':0', 22:23:14 INFO - 'HOME': '/home/cltbld', 22:23:14 INFO - 'LANG': 'en_US.UTF-8', 22:23:14 INFO - 'LANGUAGE': 'en_US:en', 22:23:14 INFO - 'LOGNAME': 'cltbld', 22:23:14 INFO - 'MAIL': '/var/mail/cltbld', 22:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:14 INFO - 'MOZ_NO_REMOTE': '1', 22:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:14 INFO - 'NO_EM_RESTART': '1', 22:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:14 INFO - 'PWD': '/builds/slave/test', 22:23:14 INFO - 'SHELL': '/bin/bash', 22:23:14 INFO - 'SHLVL': '1', 22:23:14 INFO - 'TERM': 'linux', 22:23:14 INFO - 'TMOUT': '86400', 22:23:14 INFO - 'USER': 'cltbld', 22:23:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:14 INFO - '_': '/tools/buildbot/bin/python'} 22:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 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)) 22:23:15 INFO - Cleaning up... 22:23:15 INFO - Return code: 0 22:23:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:15 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 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:23:15 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 22:23:15 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 22:23:15 INFO - Using env: {'DISPLAY': ':0', 22:23:15 INFO - 'HOME': '/home/cltbld', 22:23:15 INFO - 'LANG': 'en_US.UTF-8', 22:23:15 INFO - 'LANGUAGE': 'en_US:en', 22:23:15 INFO - 'LOGNAME': 'cltbld', 22:23:15 INFO - 'MAIL': '/var/mail/cltbld', 22:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:15 INFO - 'MOZ_NO_REMOTE': '1', 22:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:15 INFO - 'NO_EM_RESTART': '1', 22:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:15 INFO - 'PWD': '/builds/slave/test', 22:23:15 INFO - 'SHELL': '/bin/bash', 22:23:15 INFO - 'SHLVL': '1', 22:23:15 INFO - 'TERM': 'linux', 22:23:15 INFO - 'TMOUT': '86400', 22:23:15 INFO - 'USER': 'cltbld', 22:23:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:15 INFO - '_': '/tools/buildbot/bin/python'} 22:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:15 INFO - Downloading/unpacking jsonschema 22:23:15 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 22:23:15 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 22:23:15 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 22:23:15 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 22:23:15 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 22:23:15 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 22:23:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:23:17 INFO - Downloading/unpacking functools32 (from jsonschema) 22:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:17 INFO - Downloading functools32-3.2.3-2.tar.gz 22:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:23:17 INFO - warning: no files found matching '*.txt' 22:23:17 INFO - no previously-included directories found matching 'build' 22:23:17 INFO - no previously-included directories found matching 'dist' 22:23:17 INFO - no previously-included directories found matching '.git*' 22:23:17 INFO - Installing collected packages: jsonschema, functools32 22:23:17 INFO - Running setup.py install for functools32 22:23:17 INFO - warning: no files found matching '*.txt' 22:23:17 INFO - no previously-included directories found matching 'build' 22:23:17 INFO - no previously-included directories found matching 'dist' 22:23:17 INFO - no previously-included directories found matching '.git*' 22:23:17 INFO - Successfully installed jsonschema functools32 22:23:17 INFO - Cleaning up... 22:23:17 INFO - Return code: 0 22:23:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15a0e70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', '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 22:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:23:17 INFO - Using env: {'DISPLAY': ':0', 22:23:17 INFO - 'HOME': '/home/cltbld', 22:23:17 INFO - 'LANG': 'en_US.UTF-8', 22:23:17 INFO - 'LANGUAGE': 'en_US:en', 22:23:17 INFO - 'LOGNAME': 'cltbld', 22:23:17 INFO - 'MAIL': '/var/mail/cltbld', 22:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:17 INFO - 'MOZ_NO_REMOTE': '1', 22:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:17 INFO - 'NO_EM_RESTART': '1', 22:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:17 INFO - 'PWD': '/builds/slave/test', 22:23:17 INFO - 'SHELL': '/bin/bash', 22:23:17 INFO - 'SHLVL': '1', 22:23:17 INFO - 'TERM': 'linux', 22:23:17 INFO - 'TMOUT': '86400', 22:23:17 INFO - 'USER': 'cltbld', 22:23:17 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:17 INFO - '_': '/tools/buildbot/bin/python'} 22:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:17 INFO - Downloading/unpacking flake8 22:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:23:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:23:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:23:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:23:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:23:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:23:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:23:20 INFO - no previously-included directories found matching 'docs/_build' 22:23:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:23:20 INFO - Running setup.py install for pep8 22:23:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:23:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:23:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:23:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:23:20 INFO - no previously-included directories found matching 'docs/_build' 22:23:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:23:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:23:20 INFO - Cleaning up... 22:23:20 INFO - Return code: 0 22:23:20 INFO - Running post-action listener: _resource_record_post_action 22:23:20 INFO - Running post-action listener: _start_resource_monitoring 22:23:20 INFO - Starting resource monitoring. 22:23:20 INFO - ##### 22:23:20 INFO - ##### Running install step. 22:23:20 INFO - ##### 22:23:20 INFO - Running pre-action listener: _resource_record_pre_action 22:23:20 INFO - Running main action method: install 22:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:23:20 INFO - Reading from file tmpfile_stdout 22:23:20 INFO - Detecting whether we're running mozinstall >=1.0... 22:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:23:21 INFO - Reading from file tmpfile_stdout 22:23:21 INFO - Output received: 22:23:21 INFO - Usage: mozinstall [options] installer 22:23:21 INFO - Options: 22:23:21 INFO - -h, --help show this help message and exit 22:23:21 INFO - -d DEST, --destination=DEST 22:23:21 INFO - Directory to install application into. [default: 22:23:21 INFO - "/builds/slave/test"] 22:23:21 INFO - --app=APP Application being installed. [default: firefox] 22:23:21 INFO - mkdir: /builds/slave/test/build/application 22:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:23:33 INFO - Reading from file tmpfile_stdout 22:23:33 INFO - Output received: 22:23:33 INFO - /builds/slave/test/build/application/firefox/firefox 22:23:33 INFO - Running post-action listener: _resource_record_post_action 22:23:33 INFO - ##### 22:23:33 INFO - ##### Running run-tests step. 22:23:33 INFO - ##### 22:23:33 INFO - Running pre-action listener: _resource_record_pre_action 22:23:33 INFO - Running main action method: run_tests 22:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:23:33 INFO - Python 2.7.3 22:23:33 INFO - Return code: 0 22:23:33 INFO - grabbing minidump binary from tooltool 22:23: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')]} 22:23:33 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bff160>, '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 0x2c00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c004f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:23:33 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 22:23:33 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 22:23:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:23:33 INFO - Return code: 0 22:23:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:23:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:23:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:23:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:23:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:23:34 INFO - Return code: 0 22:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 22:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 22:23:34 INFO - Using env: {'DISPLAY': ':0', 22:23:34 INFO - 'HOME': '/home/cltbld', 22:23:34 INFO - 'LANG': 'en_US.UTF-8', 22:23:34 INFO - 'LANGUAGE': 'en_US:en', 22:23:34 INFO - 'LOGNAME': 'cltbld', 22:23:34 INFO - 'MAIL': '/var/mail/cltbld', 22:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:34 INFO - 'MOZ_NO_REMOTE': '1', 22:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:34 INFO - 'NO_EM_RESTART': '1', 22:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:34 INFO - 'PWD': '/builds/slave/test', 22:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:23:34 INFO - 'SHELL': '/bin/bash', 22:23:34 INFO - 'SHLVL': '1', 22:23:34 INFO - 'TERM': 'linux', 22:23:34 INFO - 'TMOUT': '86400', 22:23:34 INFO - 'USER': 'cltbld', 22:23:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679', 22:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:34 INFO - '_': '/tools/buildbot/bin/python'} 22:23:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 22:23:35 INFO - mozversion application_buildid: 20160525194948 22:23:35 INFO - mozversion application_changeset: 7c3ef5d06736bc63d138975a7194050569c62636 22:23:35 INFO - mozversion application_display_name: Firefox 22:23:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:23:35 INFO - mozversion application_name: Firefox 22:23:35 INFO - mozversion application_remotingname: firefox 22:23:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:23:35 INFO - mozversion application_vendor: Mozilla 22:23:35 INFO - mozversion application_version: 47.0 22:23:35 INFO - mozversion platform_buildid: 20160525194948 22:23:35 INFO - mozversion platform_changeset: 7c3ef5d06736bc63d138975a7194050569c62636 22:23:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:23:35 INFO - mozversion platform_version: 47.0 22:23:35 INFO - using testdate: 1464240215 22:23:35 INFO - actual date: 1464240215 22:23:35 INFO - starting webserver on 'localhost:57801' 22:23:35 INFO - SUITE-START | Running 2 tests 22:23:35 INFO - TEST-START | dromaeo_css 22:23:35 INFO - operating with platform_type : linux_ 22:23:35 INFO - Initialising browser for dromaeo_css test... 22:23:35 INFO - TEST-INFO | started process 10091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDjxFj4/profile http://localhost:57801/getInfo.html) 22:23:39 INFO - PROCESS | 10091 | 22:23:39 INFO - PROCESS | 10091 | (process:10165): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:23:40 INFO - PROCESS | 10091 | __metrics Screen width/height:1600/1200 22:23:40 INFO - PROCESS | 10091 | colorDepth:24 22:23:40 INFO - PROCESS | 10091 | Browser inner width/height: 1024/697 22:23:40 INFO - PROCESS | 10091 | __metrics 22:23:41 ERROR - PROCESS | 10091 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 22:23:42 INFO - TEST-INFO | 10091: exit 0 22:23:42 INFO - Browser initialized. 22:23:42 INFO - Running cycle 1/1 for dromaeo_css test... 22:23:42 INFO - TEST-INFO | started process 10215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDjxFj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:23:43 INFO - PROCESS | 10215 | 22:23:43 INFO - PROCESS | 10215 | (process:10283): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:23:53 INFO - PROCESS | 10215 | RSS: Main: 149073920 22:23:53 INFO - PROCESS | 10215 | 22:24:43 INFO - PROCESS | 10215 | 1464240283430 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] 22:26:51 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:57801/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57801/tests/dromaeo/cssquery-ext.html) 22:26:52 INFO - PROCESS | 10215 | RSS: Main: 154116096 22:26:52 INFO - PROCESS | 10215 | 22:29:54 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:57801/tests/dromaeo/cssquery-ext.html (next: http://localhost:57801/tests/dromaeo/cssquery-jquery.html) 22:29:54 INFO - PROCESS | 10215 | RSS: Main: 152653824 22:29:54 INFO - PROCESS | 10215 | 22:32:56 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:57801/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57801/tests/dromaeo/cssquery-mootools.html) 22:32:57 INFO - PROCESS | 10215 | RSS: Main: 151818240 22:32:57 INFO - PROCESS | 10215 | 22:35:58 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:57801/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57801/tests/dromaeo/cssquery-prototype.html) 22:35:59 INFO - PROCESS | 10215 | RSS: Main: 152768512 22:35:59 INFO - PROCESS | 10215 | 22:39:01 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:57801/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57801/tests/dromaeo/cssquery-yui.html) 22:39:02 INFO - PROCESS | 10215 | RSS: Main: 151445504 22:39:02 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:57801/tests/dromaeo/cssquery-yui.html (next: http://localhost:57801/tests/dromaeo/cssquery-dojo.html) 22:42:04 INFO - PROCESS | 10215 | RSS: Main: 155897856 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | __start_tp_report 22:42:04 INFO - PROCESS | 10215 | _x_x_mozilla_page_load 22:42:04 INFO - PROCESS | 10215 | _x_x_mozilla_page_load_details 22:42:04 INFO - PROCESS | 10215 | |i|pagename|runs| 22:42:04 INFO - PROCESS | 10215 | |0;dojo.html;3329.4007078725826;3384.306217225469;3439.896803095908;3457.3776720190353;3466.670666286702;5507.807226747064;5561.193626924093;5567.526760225375;5582.720863956796;5602.131669591215;5521.282233309664;5562.972185139079;5569.693666848321;5569.888602227953;5586.776528938837;5055.887704704959;5124.743762811863;5145.485451454843;5168.819091331804;5175.58595312376;5019.171836646949;5121.359830021247;5156.355455568054;5167;5224.79100835968;5031.245313203012;5100.821471248507;5201.453847346031;5225.555827754645;5280.683159010472;5154;5165.896682066375;5171.37943446785;5177.559907407856;5212.791488340462;4968.677035992685;5034.395872495287;5096.821611243588;5143.871403214912;5146;5381.7578208980685;5398.91901621476;5423.403425623178;5424.186372044185;5436.184572314145;5867.70661466925;5975.223220981288;6010.068439391857;6010.8497287567725;6037.184980027684;6061.363556826514;6068.362821903725;6071.119687645267;6091.208142941389;6120.510359171256;5619.522340601054;5638.859028524238;5641.661500309953;5642.633228840113;5655.8586035349035;5953.255843019622;6175.289841668266;6180.876382472416;6195.690215489208;6201.81394558164;5939.732712027969;5939.940600593939;5946.43508866657;5949.791757288474;5980.730867110903;6031.819045428644;6037.09443583466;6039.698015099228;6042.184305118841;6044.425779550936;5848.444397782204;5928.851778705481;5954.225950626391;5990.041593345044;6007.30915944672;5940.31686356066;5975.43233392827;5980.790672326448;5986.982213023796;5990.311114221833;4513.413256276663;4541.364209010741;4541.364209010741;4546.1589605922345;4572.88567785808;4009.558948515661;4031.596840315945;4033.899152521152;4048.473698419187;4099.221147981874;5586.888262234733;5631.943680563224;5670.149477578396;5702.2301989231755;5764.020116580192;6125.571210015256;6133.3866613338305;6141.416565426277;6145.8156255312415;6151.292601350812;5531.723413829292;5705.771769129188;5742.54059675225;5746.051901436216;5773.422657734277;5165.457626949192;5184.766685499161;5197.29836472079;5202.193659982709;5211.687298762086;6241.126242326078;6247.312795592481;6250.218722659668;6254.562180647402;6257.2804127525005;5844.824655260349;6031.4270144336215;6101.877962440726;6110.205673262448;6139.048447490646;6114.0365270920465;6138.109974053827;6180.258368995749;6186.938130618816;6190.7214175363115;5950.494207992196;5950.988331983486;5953.851153721192;5960.880782384242;5986.191864098291;5825.621334613236;6073.149759033827;6082.695865206811;6117.796956032775;6133.186900958431;5903.26209223847;5943.524518038633;5978.043513037893;5988.5508586855285;5998.550108741949;5758.740856661377;5952.494038006818;5962.493188079062;5963.642181468952;5975;5658.688772117573;5718.485336319751;5758.769649214152;5769.596128271149;5781.5663825214115;5865.120231965239;5939.346671866005;5944.4352786485215;5949.583529152917;5967.761289548543;5617.466340697627;5769.653820770767;5810.070388737781;5818;5818.272715910512 22:42:04 INFO - PROCESS | 10215 | |1;ext.html;563.2255648483335;584.0217635460602;637.6301744987904;641.6118248459682;643.6878114114653;38599.22801543967;39221.21557568847;39222.803885980604;39322.60677393225;39337.21325573487;43039.78480107603;43491.13017739643;43649;43704;43732.56267437325;8762.780930476758;8886.955565222164;8922.86615700765;8953.462792232454;8966.910330896706;8817.118288171163;8934.061923498037;8944.8658270126;9161.725148245563;9173.403728757643;9049.864252036225;9155.267578593697;9166.679166229183;9167.12912273333;9181.357304988653;9043.728688139367;9095.499747513884;9128.132827381389;9136.223421009223;9160.358774885794;9038.774030649287;9142.085791420872;9161.404508706913;9177.541122943892;9190.724278271662;43422;43928.56071439277;43964;43970.78014609939;44008;3173.904782856518;3762.548494180716;3866.7486613370043;3873.4577159197734;3932.6460618544183;28912.71087289142;29891.850540747375;31658.841705791554;34047.6595234047;34378.6562134378;3795.544534655859;3840.615938406165;3918.666913312372;4043.8382464701376;4079.714419990602;207475;208220;209133;209295;209547;66833.6658316715;66983;67460.32539674638;67575.66212168908;67576.6621166891;73005.6349718248;76387;76905.23094769093;76913.61543192249;77267.61366193133;17369.652606948042;17402.564935876704;17490.825091749175;17501.037442940506;17541;13418.396172172275;13533.86466135326;13564.389602467912;13664.453421863212;13667.521636742866;22127.33617991463;22503.212387566684;22550.32349029532;22600.434989125075;22801.429964251027;8457.534835584102;8544.18830211129;8598.78503037429;8607.870881936777;8623.396362254582;1102.6802227353978;1117.8323251512338;1134.2797323699344;1137.6188976692736;1179.563561482257;26918.32704182372;27288.317792055357;27579;27664.58503122455;28057.859710701723;1154.2555051991587;1159.0553698735503;1181.2676140792764;1182.9062559270044;1234.5247079874314;14245.287735613385;14801.056505045455;14841.109533428029;14948.103113813206;15000.474983375529;411140;751580;760063;767873;769339;61451;62312;62734;62929;62969.370306296354;1523.4667866246946;1538.6230373558326;1546.636540413002;1548.1794648836135;1564.9530514084595;30753;31317.686823131477;31870.52194217135;32083.372658496894;32242;48651.5134848647;49442.25836612382;49525;49776.25335619896;49899.25151122809;263399;269825;270769;271073;331244;34879.82560087183;34979.47530787091;35238.82380588183;35321.116972075906;35345.29309413849;45068.77465612651;45843.770781147214;46022.53977460183;46408.53591464042;46469.302960454945;38610.613893860704;38617.42073868838;38732.41901371538;39039.41440878333;39244.215115696956;37803.432948505244;43299.567004329554;47298.29052564283;47542;48036.7598162007;39738.60261397349;42743.786281068395;42813.35779963241;42926.570734293506;43370.78314608407;35242.82378588091;36861.63138368582;37116;37793.62206377901;37822;25728.871355643103;25947.740522594533;25990.61014084828;26144.34639134037;26276.605850912634 22:42:04 INFO - PROCESS | 10215 | |2;jquery.html;383.8121015457159;386.26031150347086;389.1167050794695;390.7284437316063;393.6024615138709;17675.381361652344;18484.445466636007;19194.520136996583;19243.711344329848;19255.71116433251;17779.55551111223;17830.910845445756;18526.351577694782;18601.720974185366;18606.534836629093;4285.657147428198;5645.802396916109;5764.7982320618785;5771.365149833515;5783.421657834225;6198.969005154968;6477.611343319416;6496.740130394778;6498.772542960997;6501.739930402779;5496.780128794843;5774.884502309972;6404.071409645599;6423.421892029716;6449.097126402307;5677.091665333527;5677.489025987639;5695.658260504362;5706.543476521868;5720.056190728525;5387.299651045339;5415.972920135414;5417.349918009864;5486.91769623456;5509.449055094458;14031.579052628438;14109.365078571489;14125.293735313193;14351.712965740626;17184.312627494885;2249.865008099503;2374.8456350337174;2557.1433569754154;2868.1108856254627;2876.2953076496183;9884.209263258923;9965.601375944954;10183.185345172442;10769;10914.290571112851;1892.3660573707825;1924.5477312831474;1947.6591596470562;1956.774970878353;1993.7906519815356;65781;66027.33972660308;67068.66465667641;67300.6634966822;68909.96635050428;10029.69910902674;10246.282760206714;10487.265891387682;10601.469926503643;10922.1808364373;14953.252337383088;15080.698386032438;15212.923935380251;15253.23733813327;15271.236438178046;7816.983792106989;8026.157253488416;8051.154628764012;8076.919230807616;8134.471259368122;7389.852202956018;7439.107307123179;7491.063617047869;7604.923950760422;7892.881606775903;4655.906881862344;4663.347131401607;4736.95263047372;4837.588804951619;4864.683795553277;1946.143696773415;1982.3061928324971;1987.145527423193;2004.5890592428518;2013.3054096336741;941.2422999485343;1038.138126170644;1063.170726833056;1066.7675053860826;1085.9837102443469;17029.744553831704;17115.86551819948;17379.913100434416;17828.197731102133;17833.643327133384;1017.0897047142765;1048.9055984961237;1052.831546952484;1069.2141276162015;1079.3092420850662;8749.518776467356;10051.899481005097;10158.644447444303;10200;10327.225458090674;428617;430015;438006;439141;441253;79515.60242198753;80478.59760701277;81016.18983810204;81358;81698;993.215359865698;1005.0803514784037;1009.4094954451728;1021.3718563083798;1061.0768631290825;15829;15955.361785528448;15986.440474583798;16001.679966400374;16012.359505619645;36486.27027459489;37561.4365784508;37633;38553.80723096366;39263.41104883486;47642;48132.79668008328;50093.24860127174;50749;51775.74112129415;8501.787455313666;8687.087855775053;8751.64993400257;8783.253423459077;8808.779780505538;11493.942530287295;12322.383880806103;12650.746985060432;13048.478060877458;13142.211467311992;10802.351858888493;10952.123830093415;10992.340459572451;11096.778064438828;11190.66428007161;10064.647737329451;10224.795504090025;10729.570817167227;10856.13150947938;11378.943105284421;10640;10656.360618362924;10714.303570267908;10726.785464290515;10874.836877447004;8235.176482351717;8395.916040839513;8455.069942306465;8489.957550212457;8679.435836670596;11059.83410248863;12044.277343359427;12135.211211271238;12166.666666666666;12186.268823870596 22:42:04 INFO - PROCESS | 10215 | |3;mootools.html;1631.8041834979804;1650.6451113010703;1913.2825190553533;1927.2098439639751;1992.0637300468784;8475.067742548315;8530.70142545011;8650;8689.73930782076;8720.040795512488;8648.91351086489;8691.043985161627;8694.39139260252;8723.563821808915;8739.781505462366;2367.562001029806;2383.4041489627593;2383.666286719852;2389.7371289158177;2395.9041638334447;2394.0423830467867;2426.162973774045;2460.8646524441147;2463.692038495188;2465.494573612405;2417.2627348658652;2430.0887167312258;2441.2066078524463;2450.0812195426715;2451.3626457121186;2427.6965379327585;2438.878056097197;2441.633754936756;2444.9511009779794;2461.778439940414;2446.3394883381566;2462.3597864555345;2480.925572232818;2481.2060140754966;2483.5902076157413;8689.652413903435;8733.257673097794;8737.475751454933;8753.562321883945;8756.168164024408;5330.893382132374;5432.076546987022;5439.5104440600535;5451.454854514517;5456.7544460499375;3185.9203519911957;3198.696123868252;3250.4474239379124;3264.951025734616;3284.4088064148445;932.2821427500854;939.4175611121149;939.793245485992;940.7036783413203;969.471637957315;12349.93825030878;12383.504659813687;12432.316222607753;12448.502059917593;12458.626241212778;4431.468223813099;4496.865094047118;4522.050369422458;4552.317152427162;4585.770711464414;9773.364731292444;9794.118529332252;9801.460919649346;9803.656872009446;9812.607495700235;5284.3658760948165;5302.337207849019;5304.893902121936;5312.548433383128;5326.840194794162;4197.097624010852;4778.832740854054;4818.590419814285;4832.323474713543;4844.273358996179;3722.16251343451;3736.103335199587;3742.045778326564;3815.6947444204397;3833.290841194388;1123.9269447485888;1125.5160281079216;1134.2173900008968;1137.7098839795965;1137.9487923043482;1156.9537218511334;1176.3236139219982;1178.0634395655475;1220.6582156996055;1245.4520011195045;8128;8212.219839115274;8280;8280.668773249123;8323.458975166715;1142.628645690154;1197.7963746163173;1234.802241825428;1239.5599562155485;1241.6895776055985;6473.77341793035;6488.351164883474;6575.638339891256;6584.1440612721;6594.7032383542855;9946.055124763136;10280.897191028143;10293;10369.325993810378;10415.375077495375;10082.092611664986;10120.797584048278;10269.075783179549;10331.94834025825;10367.481625918674;8307.501549907025;8365.958170209231;8385.287250583646;8391.035030971394;8470.15298470148;7916.327112195528;7983.760487185394;7988.560629165451;8067.1529489402765;8093.919060809317;9438.669646562337;9477.573509191965;9547;9552.092551207903;9558.187554057982;9781.021897810162;9916.603335866484;9952.203823694232;10019.398836069568;10152.847707284544;5928.110783382354;6904.240533541407;7097.077379940574;7112.928870711226;7181.964090179516;8307.584620768817;8342.83314333722;8344.916550834414;8353.0811610724;8409.83180336402;7189.460790440633;7261.273872612696;7299;7353.852922941618;7434.182239953492;7272.381847543018;7276.163241227115;7307.488475806856;7360;7535.660895259617;7830.725924592612;7847.0975837777105;7854.72508462224;7879.172686867796;7889.408294377829;7175.497715159889;7252.492325537372;7256.020437240905;7261.673224704795;7327.413806895329;7237.059182306267;7279.636018199175;7300.707971681073;7311.634418279171;7326.560406375635 22:42:04 INFO - PROCESS | 10215 | |4;prototype.html;328.1582740271203;333.2784521510929;333.72134267886315;336.36595018390335;338.6985582831279;6335.9366406335985;6405.775797847076;6406.551541392105;6422;6423.64669943153;6362.14111095002;6364.554481186319;6382.648954307511;6440.194975628046;6455.709493072823;4639.652026098056;4769.070031343889;4800.783964721579;4810.759462026894;4814.73518956459;4796.5443282888245;4805.6155507559315;4805.711657300573;4822.397200349957;4832.73419961902;4761.59526440253;4768.260919557457;4768.713877167381;4776.28355746639;4782.665213435061;4783.736894470802;4791.161546729309;4802.327674125625;4806.231003039515;4806.879828004293;4145.316022856225;4150.252954468195;4158.37624356346;4158.521769996459;4163.479565054368;6044.667543285118;6065.848353791191;6066.878662426727;6070.6357618543025;6072.908906366408;5341.866453338697;5497.065498865202;5529.253550770634;5529.557635389199;5536.612437129403;6735.663216839187;6745.3591908768585;6753.3921947025;6755.432935484484;6760.904119722853;4508.954910450886;4510.458744950594;4513.909721805546;4515.819367225307;4526.728396296233;6968.407685346701;7043.401310888581;7082.681279342442;7084.14990201174;7084.14990201174;4577;4670.206064968964;4678.8128474861305;4684.156851766715;4691.483936766953;4680.15757163707;4709.27006314015;4716.127516409407;4718.9292160617615;4726.220173671374;5491.560675145979;5530.917036244459;5531.529819965268;5533.418991005967;5541.5289700375115;6814.557053791487;6857.177138743383;6858.142732158481;6868.210155832044;6873;1634.7466142747894;1680.9411670591714;1681.756145358916;1682.9747553786704;1687.0889719551305;1051.0540513537876;1082.2478377527543;1085.5006696919506;1086.9021788039115;1087.1574529739514;6394.552381333262;6404.615723056539;6406.071119687619;6411.775587854403;6508.576942498722;7020.543664661781;7025.859482810315;7032.789016329519;7034.929650703428;7040.929590704028;6339.11252424661;6429.45349645276;6532.118164047888;6589.077529145923;6594.175728033996;3816.8282427290837;3825.5600605930676;3841.7310788244554;3842.51968503937;3849.576546579874;7299.41604671625;7309.817254568678;7317.634118294064;7322.121345438475;7322.853542929111;7258.637068146571;7281.635918204069;7286.599237042014;7294.927050729425;7303.160136584361;6986.371226589631;7295.89056164158;7299.70801167958;7301.890471643036;7311.3785328247695;7036.120484939383;7059.541129826544;7076.787696369117;7084.539504932163;7088.113985751781;6955.374016338554;6959.930400695928;6979.40675042627;6982.615956122462;6986.476014298846;7282.271772822675;7282.927170728225;7287.234840341688;7287.672054757655;7313.48805583604;4492.505824359383;4624.953750462452;4638.141943740419;4641.466231383434;4701.694389864648;6999.160100787938;7031.718731250693;7050.541714788523;7057.505974581935;7076.787696368911;6807.89788153188;6817.113775209389;6818.556793808387;6827;6827.590344579341;6796.626185559841;6800.863982720417;6805.251422343637;6808.421284190899;6809.114815074008;6522.706478208397;6697.866042679217;6720.1599800025;6736.562123461959;6738.191417029988;6820.35206655367;6848.520603557703;6858;6868.244493105654;6898.379145876896;6758.628275444898;6771.830704232237;6774.695138718671;6774.762883299061;6789.72841086351 22:42:04 INFO - PROCESS | 10215 | |5;yui.html;723.2333726250175;730.8647900138471;791.6591981836648;847.737201467545;890.3589415620751;14695;15017.474388396395;15194.620134496628;15376.846231537682;15699.450519231828;16389.42637007705;16406.589835254126;16409.261583228752;16409.671806563863;16554.420595279167;937.4188003437878;943.1558754914347;950.4724877692878;955.0497255231055;962.5427921737154;948.6964171465133;960.9711708648716;961.8990006049369;962.3071388600197;965.3049804141042;990.782027953849;1003.5534187286661;1006.9194464442827;1008.374807619277;1009.4952523738131;984.5963155106408;985.8521221816713;990.2424645146468;991.8760154980628;995.3679413572361;732.1543617122232;735.6174789109687;735.731458017825;736.4403053679189;736.5507040705165;15521.45674901373;15561.066336019874;15587.922060389625;15606.219689015505;15609.297581608742;13071.346432678423;13196.14225075367;13209.603711888658;13528.18830870141;13565.118267312593;11216.270942388719;11382;11391.259568128045;11528.250663706833;11559.94220028903;3683.0608194910396;3697.7041836653;3725.795081270529;3727.2172843702856;3729.757565758217;52876;52926;54455;54533.18200227;54857.72571137159;10338.896611033793;10415.947920260502;10551.261411701107;10565.735856603493;10650.573977040987;17435.912820435817;17589.7361539577;17656.646867062587;17661.116944152996;17720.734188987175;7545.320921117126;7743.4966727162555;7745.728899488491;7891.960540197262;8014.255507132703;4395.780210989437;4534.501204867462;4589.128065667513;4602.585767280961;4656.580907718321;3494.8776792812127;3520.436730123219;3527.700145487611;3532.8586856525453;3546.680798728127;589.1222079102107;598.9191459153046;601.5849064145725;603.4177019176516;606.6147996022469;692.3388164303078;723.5767076260341;741.8442127153359;751.1136858507015;752.7177308509309;8890.911090889138;9131.954340228256;9135.269178465707;9136.58885350161;9205.125513076247;637.0571554099959;651.9047999361119;672.3612568060264;734.904462419882;736.2747693521877;4015.8996025099605;4185.121124563815;4335.3063509838275;4492.348609451677;4539.6368290536675;57342.7132864333;57374.426255737744;57487;57842;58453.41546584565;52031.47968520342;53035.20447193218;53930.46069539255;59680.70159649174;60063.69968150131;46845.531544684796;47867.52132478631;48005.279920801215;48334.758326208146;48600.7569962155;9541.618335266512;9584.185344245818;9634.506651469033;9798.510074496104;9823.803523929624;35097.64902350944;37711.434328484545;38458.61541384662;38773.22453550857;38870.83387498379;42910.78544607257;43076;43659.78170109129;43769;44132;12129.80356974681;12496.312702801433;12564.37178141071;12613.747725045265;12719.300438475602;12703;12767.74464510686;13776.586702398945;13801.140590131416;14113.929430352782;12750.48998040068;12815.935920320711;12935.094543381872;13139.408726607135;13209.801852972021;12658.493660253487;12695.55565555201;12755.553555625509;12845.100842940905;12874.613761587167;12441.564545240873;12692.36538173106;12776.425060872469;12895.935520322339;13300.600981970556;10375.584976600852;10553.788924221626;10782.892171078503;10817.134629229486;10870.510827012962;10747.731306717395;10832.5125369357;10921;10932.890671093188;10963.122950164126 22:42:04 INFO - PROCESS | 10215 | __end_tp_report 22:42:04 INFO - PROCESS | 10215 | __start_cc_report 22:42:04 INFO - PROCESS | 10215 | _x_x_mozilla_cycle_collect,331 22:42:04 INFO - PROCESS | 10215 | __end_cc_report 22:42:04 INFO - PROCESS | 10215 | __startTimestamp1464241324270__endTimestamp 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | ------- Summary: start ------- 22:42:04 INFO - PROCESS | 10215 | Number of tests: 6 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | [#0] dojo.html Cycles:165 Average:5590.32 Median:5781.57 stddev:626.85 (10.8%) stddev-sans-first:603.15 22:42:04 INFO - PROCESS | 10215 | Values: 3329.4 3384.3 3439.9 3457.4 3466.7 5507.8 5561.2 5567.5 5582.7 5602.1 5521.3 5563.0 5569.7 5569.9 5586.8 5055.9 5124.7 5145.5 5168.8 5175.6 5019.2 5121.4 5156.4 5167.0 5224.8 5031.2 5100.8 5201.5 5225.6 5280.7 5154.0 5165.9 5171.4 5177.6 5212.8 4968.7 5034.4 5096.8 5143.9 5146.0 5381.8 5398.9 5423.4 5424.2 5436.2 5867.7 5975.2 6010.1 6010.8 6037.2 6061.4 6068.4 6071.1 6091.2 6120.5 5619.5 5638.9 5641.7 5642.6 5655.9 5953.3 6175.3 6180.9 6195.7 6201.8 5939.7 5939.9 5946.4 5949.8 5980.7 6031.8 6037.1 6039.7 6042.2 6044.4 5848.4 5928.9 5954.2 5990.0 6007.3 5940.3 5975.4 5980.8 5987.0 5990.3 4513.4 4541.4 4541.4 4546.2 4572.9 4009.6 4031.6 4033.9 4048.5 4099.2 5586.9 5631.9 5670.1 5702.2 5764.0 6125.6 6133.4 6141.4 6145.8 6151.3 5531.7 5705.8 5742.5 5746.1 5773.4 5165.5 5184.8 5197.3 5202.2 5211.7 6241.1 6247.3 6250.2 6254.6 6257.3 5844.8 6031.4 6101.9 6110.2 6139.0 6114.0 6138.1 6180.3 6186.9 6190.7 5950.5 5951.0 5953.9 5960.9 5986.2 5825.6 6073.1 6082.7 6117.8 6133.2 5903.3 5943.5 5978.0 5988.6 5998.6 5758.7 5952.5 5962.5 5963.6 5975.0 5658.7 5718.5 5758.8 5769.6 5781.6 5865.1 5939.3 5944.4 5949.6 5967.8 5617.5 5769.7 5810.1 5818.0 5818.3 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | [#1] ext.html Cycles:180 Average:57198.65 Median:21588.43 stddev:122974.94 (569.6%) stddev-sans-first:123246.40 22:42:04 INFO - PROCESS | 10215 | Values: 563.2 584.0 637.6 641.6 643.7 38599.2 39221.2 39222.8 39322.6 39337.2 43039.8 43491.1 43649.0 43704.0 43732.6 8762.8 8887.0 8922.9 8953.5 8966.9 8817.1 8934.1 8944.9 9161.7 9173.4 9049.9 9155.3 9166.7 9167.1 9181.4 9043.7 9095.5 9128.1 9136.2 9160.4 9038.8 9142.1 9161.4 9177.5 9190.7 43422.0 43928.6 43964.0 43970.8 44008.0 3173.9 3762.5 3866.7 3873.5 3932.6 28912.7 29891.9 31658.8 34047.7 34378.7 3795.5 3840.6 3918.7 4043.8 4079.7 207475.0 208220.0 209133.0 209295.0 209547.0 66833.7 66983.0 67460.3 67575.7 67576.7 73005.6 76387.0 76905.2 76913.6 77267.6 17369.7 17402.6 17490.8 17501.0 17541.0 13418.4 13533.9 13564.4 13664.5 13667.5 22127.3 22503.2 22550.3 22600.4 22801.4 8457.5 8544.2 8598.8 8607.9 8623.4 1102.7 1117.8 1134.3 1137.6 1179.6 26918.3 27288.3 27579.0 27664.6 28057.9 1154.3 1159.1 1181.3 1182.9 1234.5 14245.3 14801.1 14841.1 14948.1 15000.5 411140.0 751580.0 760063.0 767873.0 769339.0 61451.0 62312.0 62734.0 62929.0 62969.4 1523.5 1538.6 1546.6 1548.2 1565.0 30753.0 31317.7 31870.5 32083.4 32242.0 48651.5 49442.3 49525.0 49776.3 49899.3 263399.0 269825.0 270769.0 271073.0 331244.0 34879.8 34979.5 35238.8 35321.1 35345.3 45068.8 45843.8 46022.5 46408.5 46469.3 38610.6 38617.4 38732.4 39039.4 39244.2 37803.4 43299.6 47298.3 47542.0 48036.8 39738.6 42743.8 42813.4 42926.6 43370.8 35242.8 36861.6 37116.0 37793.6 37822.0 25728.9 25947.7 25990.6 26144.3 26276.6 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | [#2] jquery.html Cycles:180 Average:25981.50 Median:2312.36 stddev:71569.42 (3095.1%) stddev-sans-first:71744.38 22:42:04 INFO - PROCESS | 10215 | Values: 383.8 386.3 389.1 390.7 393.6 17675.4 18484.4 19194.5 19243.7 19255.7 17779.6 17830.9 18526.4 18601.7 18606.5 4285.7 5645.8 5764.8 5771.4 5783.4 6199.0 6477.6 6496.7 6498.8 6501.7 5496.8 5774.9 6404.1 6423.4 6449.1 5677.1 5677.5 5695.7 5706.5 5720.1 5387.3 5416.0 5417.3 5486.9 5509.4 14031.6 14109.4 14125.3 14351.7 17184.3 2249.9 2374.8 2557.1 2868.1 2876.3 9884.2 9965.6 10183.2 10769.0 10914.3 1892.4 1924.5 1947.7 1956.8 1993.8 65781.0 66027.3 67068.7 67300.7 68910.0 10029.7 10246.3 10487.3 10601.5 10922.2 14953.3 15080.7 15212.9 15253.2 15271.2 7817.0 8026.2 8051.2 8076.9 8134.5 7389.9 7439.1 7491.1 7604.9 7892.9 4655.9 4663.3 4737.0 4837.6 4864.7 1946.1 1982.3 1987.1 2004.6 2013.3 941.2 1038.1 1063.2 1066.8 1086.0 17029.7 17115.9 17379.9 17828.2 17833.6 1017.1 1048.9 1052.8 1069.2 1079.3 8749.5 10051.9 10158.6 10200.0 10327.2 428617.0 430015.0 438006.0 439141.0 441253.0 79515.6 80478.6 81016.2 81358.0 81698.0 993.2 1005.1 1009.4 1021.4 1061.1 15829.0 15955.4 15986.4 16001.7 16012.4 36486.3 37561.4 37633.0 38553.8 39263.4 47642.0 48132.8 50093.2 50749.0 51775.7 8501.8 8687.1 8751.6 8783.3 8808.8 11493.9 12322.4 12650.7 13048.5 13142.2 10802.4 10952.1 10992.3 11096.8 11190.7 10064.6 10224.8 10729.6 10856.1 11378.9 10640.0 10656.4 10714.3 10726.8 10874.8 8235.2 8395.9 8455.1 8490.0 8679.4 11059.8 12044.3 12135.2 12166.7 12186.3 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | [#3] mootools.html Cycles:180 Average:6030.72 Median:5692.43 stddev:3200.95 (56.2%) stddev-sans-first:3192.85 22:42:04 INFO - PROCESS | 10215 | Values: 1631.8 1650.6 1913.3 1927.2 1992.1 8475.1 8530.7 8650.0 8689.7 8720.0 8648.9 8691.0 8694.4 8723.6 8739.8 2367.6 2383.4 2383.7 2389.7 2395.9 2394.0 2426.2 2460.9 2463.7 2465.5 2417.3 2430.1 2441.2 2450.1 2451.4 2427.7 2438.9 2441.6 2445.0 2461.8 2446.3 2462.4 2480.9 2481.2 2483.6 8689.7 8733.3 8737.5 8753.6 8756.2 5330.9 5432.1 5439.5 5451.5 5456.8 3185.9 3198.7 3250.4 3265.0 3284.4 932.3 939.4 939.8 940.7 969.5 12349.9 12383.5 12432.3 12448.5 12458.6 4431.5 4496.9 4522.1 4552.3 4585.8 9773.4 9794.1 9801.5 9803.7 9812.6 5284.4 5302.3 5304.9 5312.5 5326.8 4197.1 4778.8 4818.6 4832.3 4844.3 3722.2 3736.1 3742.0 3815.7 3833.3 1123.9 1125.5 1134.2 1137.7 1137.9 1157.0 1176.3 1178.1 1220.7 1245.5 8128.0 8212.2 8280.0 8280.7 8323.5 1142.6 1197.8 1234.8 1239.6 1241.7 6473.8 6488.4 6575.6 6584.1 6594.7 9946.1 10280.9 10293.0 10369.3 10415.4 10082.1 10120.8 10269.1 10331.9 10367.5 8307.5 8366.0 8385.3 8391.0 8470.2 7916.3 7983.8 7988.6 8067.2 8093.9 9438.7 9477.6 9547.0 9552.1 9558.2 9781.0 9916.6 9952.2 10019.4 10152.8 5928.1 6904.2 7097.1 7112.9 7182.0 8307.6 8342.8 8344.9 8353.1 8409.8 7189.5 7261.3 7299.0 7353.9 7434.2 7272.4 7276.2 7307.5 7360.0 7535.7 7830.7 7847.1 7854.7 7879.2 7889.4 7175.5 7252.5 7256.0 7261.7 7327.4 7237.1 7279.6 7300.7 7311.6 7326.6 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | [#4] prototype.html Cycles:180 Average:5649.20 Median:6416.89 stddev:1751.26 (27.3%) stddev-sans-first:1710.02 22:42:04 INFO - PROCESS | 10215 | Values: 328.2 333.3 333.7 336.4 338.7 6335.9 6405.8 6406.6 6422.0 6423.6 6362.1 6364.6 6382.6 6440.2 6455.7 4639.7 4769.1 4800.8 4810.8 4814.7 4796.5 4805.6 4805.7 4822.4 4832.7 4761.6 4768.3 4768.7 4776.3 4782.7 4783.7 4791.2 4802.3 4806.2 4806.9 4145.3 4150.3 4158.4 4158.5 4163.5 6044.7 6065.8 6066.9 6070.6 6072.9 5341.9 5497.1 5529.3 5529.6 5536.6 6735.7 6745.4 6753.4 6755.4 6760.9 4509.0 4510.5 4513.9 4515.8 4526.7 6968.4 7043.4 7082.7 7084.1 7084.1 4577.0 4670.2 4678.8 4684.2 4691.5 4680.2 4709.3 4716.1 4718.9 4726.2 5491.6 5530.9 5531.5 5533.4 5541.5 6814.6 6857.2 6858.1 6868.2 6873.0 1634.7 1680.9 1681.8 1683.0 1687.1 1051.1 1082.2 1085.5 1086.9 1087.2 6394.6 6404.6 6406.1 6411.8 6508.6 7020.5 7025.9 7032.8 7034.9 7040.9 6339.1 6429.5 6532.1 6589.1 6594.2 3816.8 3825.6 3841.7 3842.5 3849.6 7299.4 7309.8 7317.6 7322.1 7322.9 7258.6 7281.6 7286.6 7294.9 7303.2 6986.4 7295.9 7299.7 7301.9 7311.4 7036.1 7059.5 7076.8 7084.5 7088.1 6955.4 6959.9 6979.4 6982.6 6986.5 7282.3 7282.9 7287.2 7287.7 7313.5 4492.5 4625.0 4638.1 4641.5 4701.7 6999.2 7031.7 7050.5 7057.5 7076.8 6807.9 6817.1 6818.6 6827.0 6827.6 6796.6 6800.9 6805.3 6808.4 6809.1 6522.7 6697.9 6720.2 6736.6 6738.2 6820.4 6848.5 6858.0 6868.2 6898.4 6758.6 6771.8 6774.7 6774.8 6789.7 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - PROCESS | 10215 | [#5] yui.html Cycles:180 Average:14800.95 Median:23547.95 stddev:16661.80 (70.8%) stddev-sans-first:16675.00 22:42:04 INFO - PROCESS | 10215 | Values: 723.2 730.9 791.7 847.7 890.4 14695.0 15017.5 15194.6 15376.8 15699.5 16389.4 16406.6 16409.3 16409.7 16554.4 937.4 943.2 950.5 955.0 962.5 948.7 961.0 961.9 962.3 965.3 990.8 1003.6 1006.9 1008.4 1009.5 984.6 985.9 990.2 991.9 995.4 732.2 735.6 735.7 736.4 736.6 15521.5 15561.1 15587.9 15606.2 15609.3 13071.3 13196.1 13209.6 13528.2 13565.1 11216.3 11382.0 11391.3 11528.3 11559.9 3683.1 3697.7 3725.8 3727.2 3729.8 52876.0 52926.0 54455.0 54533.2 54857.7 10338.9 10415.9 10551.3 10565.7 10650.6 17435.9 17589.7 17656.6 17661.1 17720.7 7545.3 7743.5 7745.7 7892.0 8014.3 4395.8 4534.5 4589.1 4602.6 4656.6 3494.9 3520.4 3527.7 3532.9 3546.7 589.1 598.9 601.6 603.4 606.6 692.3 723.6 741.8 751.1 752.7 8890.9 9132.0 9135.3 9136.6 9205.1 637.1 651.9 672.4 734.9 736.3 4015.9 4185.1 4335.3 4492.3 4539.6 57342.7 57374.4 57487.0 57842.0 58453.4 52031.5 53035.2 53930.5 59680.7 60063.7 46845.5 47867.5 48005.3 48334.8 48600.8 9541.6 9584.2 9634.5 9798.5 9823.8 35097.6 37711.4 38458.6 38773.2 38870.8 42910.8 43076.0 43659.8 43769.0 44132.0 12129.8 12496.3 12564.4 12613.7 12719.3 12703.0 12767.7 13776.6 13801.1 14113.9 12750.5 12815.9 12935.1 13139.4 13209.8 12658.5 12695.6 12755.6 12845.1 12874.6 12441.6 12692.4 12776.4 12895.9 13300.6 10375.6 10553.8 10782.9 10817.1 10870.5 10747.7 10832.5 10921.0 10932.9 10963.1 22:42:04 INFO - PROCESS | 10215 | -------- Summary: end -------- 22:42:04 INFO - PROCESS | 10215 | 22:42:04 INFO - TEST-INFO | 10215: exit 0 22:42:04 INFO - TEST-OK | dromaeo_css | took 1109973ms 22:42:04 INFO - TEST-START | kraken 22:42:04 INFO - operating with platform_type : linux_ 22:42:04 INFO - Initialising browser for kraken test... 22:42:05 INFO - TEST-INFO | started process 10454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprpqTcN/profile http://localhost:57801/getInfo.html) 22:42:09 INFO - PROCESS | 10454 | 22:42:09 INFO - PROCESS | 10454 | (process:10532): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:42:10 INFO - PROCESS | 10454 | __metrics Screen width/height:1600/1200 22:42:10 INFO - PROCESS | 10454 | colorDepth:24 22:42:10 INFO - PROCESS | 10454 | Browser inner width/height: 1024/697 22:42:10 INFO - PROCESS | 10454 | __metrics 22:42:10 ERROR - PROCESS | 10454 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 22:42:11 INFO - TEST-INFO | 10454: exit 0 22:42:11 INFO - Browser initialized. 22:42:11 INFO - Running cycle 1/1 for kraken test... 22:42:11 INFO - TEST-INFO | started process 10582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprpqTcN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:13 INFO - PROCESS | 10582 | 22:42:13 INFO - PROCESS | 10582 | (process:10652): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:42:23 INFO - PROCESS | 10582 | RSS: Main: 149745664 22:42:23 INFO - PROCESS | 10582 | 22:42:26 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57801/tests/kraken/driver.html?testName=audio-beat-detection) 22:42:26 INFO - PROCESS | 10582 | RSS: Main: 153939968 22:42:26 INFO - PROCESS | 10582 | 22:42:29 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57801/tests/kraken/driver.html?testName=audio-dft) 22:42:30 INFO - PROCESS | 10582 | RSS: Main: 154165248 22:42:30 INFO - PROCESS | 10582 | 22:42:33 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57801/tests/kraken/driver.html?testName=audio-fft) 22:42:33 INFO - PROCESS | 10582 | RSS: Main: 154734592 22:42:33 INFO - PROCESS | 10582 | 22:42:35 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57801/tests/kraken/driver.html?testName=audio-oscillator) 22:42:36 INFO - PROCESS | 10582 | RSS: Main: 154894336 22:42:36 INFO - PROCESS | 10582 | 22:42:38 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57801/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:42:39 INFO - PROCESS | 10582 | RSS: Main: 154722304 22:42:39 INFO - PROCESS | 10582 | 22:42:42 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57801/tests/kraken/driver.html?testName=imaging-darkroom) 22:42:42 INFO - PROCESS | 10582 | RSS: Main: 154861568 22:42:42 INFO - PROCESS | 10582 | 22:42:46 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57801/tests/kraken/driver.html?testName=imaging-desaturate) 22:42:46 INFO - PROCESS | 10582 | RSS: Main: 155029504 22:42:46 INFO - PROCESS | 10582 | 22:42:49 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57801/tests/kraken/driver.html?testName=json-parse-financial) 22:42:50 INFO - PROCESS | 10582 | RSS: Main: 155168768 22:42:50 INFO - PROCESS | 10582 | 22:42:51 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57801/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:42:52 INFO - PROCESS | 10582 | RSS: Main: 155017216 22:42:52 INFO - PROCESS | 10582 | 22:42:54 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:42:54 INFO - PROCESS | 10582 | RSS: Main: 154980352 22:42:54 INFO - PROCESS | 10582 | 22:42:56 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:42:57 INFO - PROCESS | 10582 | RSS: Main: 155230208 22:42:57 INFO - PROCESS | 10582 | 22:42:59 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:43:00 INFO - PROCESS | 10582 | RSS: Main: 155439104 22:43:00 INFO - PROCESS | 10582 | 22:43:02 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:43:03 INFO - PROCESS | 10582 | RSS: Main: 155361280 22:43:03 INFO - PROCESS | 10582 | 22:43:04 INFO - PROCESS | 10582 | Cycle 1(1): loaded http://localhost:57801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57801/tests/kraken/driver.html?testName=ai-astar) 22:43:05 INFO - PROCESS | 10582 | RSS: Main: 157253632 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | __start_tp_report 22:43:05 INFO - PROCESS | 10582 | _x_x_mozilla_page_load 22:43:05 INFO - PROCESS | 10582 | _x_x_mozilla_page_load_details 22:43:05 INFO - PROCESS | 10582 | |i|pagename|runs| 22:43:05 INFO - PROCESS | 10582 | |0;ai-astar;107;110;103;111;110;113;100;112;111;109 22:43:05 INFO - PROCESS | 10582 | |1;audio-beat-detection;159;127;154;159;127;155;160;131;169;135 22:43:05 INFO - PROCESS | 10582 | |2;audio-dft;161;163;163;163;163;165;164;162;165;162 22:43:05 INFO - PROCESS | 10582 | |3;audio-fft;76;79;74;164;76;74;75;73;176;76 22:43:05 INFO - PROCESS | 10582 | |4;audio-oscillator;93;95;151;93;92;94;142;92;93;147 22:43:05 INFO - PROCESS | 10582 | |5;imaging-gaussian-blur;117;117;117;117;118;118;117;118;117;116 22:43:05 INFO - PROCESS | 10582 | |6;imaging-darkroom;146;146;145;146;146;147;147;146;147;147 22:43:05 INFO - PROCESS | 10582 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;96 22:43:05 INFO - PROCESS | 10582 | |8;json-parse-financial;56;56;55;56;60;56;58;57;65;56 22:43:05 INFO - PROCESS | 10582 | |9;json-stringify-tinderbox;64;64;64;64;65;64;65;65;65;65 22:43:05 INFO - PROCESS | 10582 | |10;stanford-crypto-aes;78;78;80;80;78;77;78;79;79;79 22:43:05 INFO - PROCESS | 10582 | |11;stanford-crypto-ccm;118;113;116;111;111;124;121;114;113;115 22:43:05 INFO - PROCESS | 10582 | |12;stanford-crypto-pbkdf2;135;141;138;140;128;143;133;137;141;130 22:43:05 INFO - PROCESS | 10582 | |13;stanford-crypto-sha256-iterative;71;67;69;65;69;66;68;65;67;64 22:43:05 INFO - PROCESS | 10582 | __end_tp_report 22:43:05 INFO - PROCESS | 10582 | __start_cc_report 22:43:05 INFO - PROCESS | 10582 | _x_x_mozilla_cycle_collect,827 22:43:05 INFO - PROCESS | 10582 | __end_cc_report 22:43:05 INFO - PROCESS | 10582 | __startTimestamp1464241385115__endTimestamp 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | ------- Summary: start ------- 22:43:05 INFO - PROCESS | 10582 | Number of tests: 14 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:4.14 (3.7%) stddev-sans-first:4.35 22:43:05 INFO - PROCESS | 10582 | Values: 107.0 110.0 103.0 111.0 110.0 113.0 100.0 112.0 111.0 109.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:157.00 stddev:15.81 (10.1%) stddev-sans-first:16.22 22:43:05 INFO - PROCESS | 10582 | Values: 159.0 127.0 154.0 159.0 127.0 155.0 160.0 131.0 169.0 135.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.29 (0.8%) stddev-sans-first:1.12 22:43:05 INFO - PROCESS | 10582 | Values: 161.0 163.0 163.0 163.0 163.0 165.0 164.0 162.0 165.0 162.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:40.03 (53.0%) stddev-sans-first:41.91 22:43:05 INFO - PROCESS | 10582 | Values: 76.0 79.0 74.0 164.0 76.0 74.0 75.0 73.0 176.0 76.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:25.96 (27.9%) stddev-sans-first:26.86 22:43:05 INFO - PROCESS | 10582 | Values: 93.0 95.0 151.0 93.0 92.0 94.0 142.0 92.0 93.0 147.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 22:43:05 INFO - PROCESS | 10582 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 116.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:43:05 INFO - PROCESS | 10582 | Values: 146.0 146.0 145.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:43:05 INFO - PROCESS | 10582 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.50 stddev:2.99 (5.3%) stddev-sans-first:3.12 22:43:05 INFO - PROCESS | 10582 | Values: 56.0 56.0 55.0 56.0 60.0 56.0 58.0 57.0 65.0 56.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 22:43:05 INFO - PROCESS | 10582 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 22:43:05 INFO - PROCESS | 10582 | Values: 78.0 78.0 80.0 80.0 78.0 77.0 78.0 79.0 79.0 79.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:115.50 stddev:4.27 (3.7%) stddev-sans-first:4.44 22:43:05 INFO - PROCESS | 10582 | Values: 118.0 113.0 116.0 111.0 111.0 124.0 121.0 114.0 113.0 115.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.60 Median:139.00 stddev:5.02 (3.6%) stddev-sans-first:5.29 22:43:05 INFO - PROCESS | 10582 | Values: 135.0 141.0 138.0 140.0 128.0 143.0 133.0 137.0 141.0 130.0 22:43:05 INFO - PROCESS | 10582 | 22:43:05 INFO - PROCESS | 10582 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:2.18 (3.2%) stddev-sans-first:1.80 22:43:05 INFO - PROCESS | 10582 | Values: 71.0 67.0 69.0 65.0 69.0 66.0 68.0 65.0 67.0 64.0 22:43:05 INFO - PROCESS | 10582 | -------- Summary: end -------- 22:43:05 INFO - PROCESS | 10582 | 22:43:06 INFO - TEST-INFO | 10582: exit 0 22:43:06 INFO - TEST-OK | kraken | took 61062ms 22:43:06 INFO - SUITE-END | took 1171s 22:43:06 INFO - Completed test suite (00:19:31) 22:43:06 INFO - javascript benchmark 22:43:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3329.4007078725826, 3384.306217225469, 3439.896803095908, 3457.3776720190353, 3466.670666286702, 5507.807226747064, 5561.193626924093, 5567.526760225375, 5582.720863956796, 5602.131669591215, 5521.282233309664, 5562.972185139079, 5569.693666848321, 5569.888602227953, 5586.776528938837, 5055.887704704959, 5124.743762811863, 5145.485451454843, 5168.819091331804, 5175.58595312376, 5019.171836646949, 5121.359830021247, 5156.355455568054, 5167.0, 5224.79100835968, 5031.245313203012, 5100.821471248507, 5201.453847346031, 5225.555827754645, 5280.683159010472, 5154.0, 5165.896682066375, 5171.37943446785, 5177.559907407856, 5212.791488340462, 4968.677035992685, 5034.395872495287, 5096.821611243588, 5143.871403214912, 5146.0, 5381.7578208980685, 5398.91901621476, 5423.403425623178, 5424.186372044185, 5436.184572314145, 5867.70661466925, 5975.223220981288, 6010.068439391857, 6010.8497287567725, 6037.184980027684, 6061.363556826514, 6068.362821903725, 6071.119687645267, 6091.208142941389, 6120.510359171256, 5619.522340601054, 5638.859028524238, 5641.661500309953, 5642.633228840113, 5655.8586035349035, 5953.255843019622, 6175.289841668266, 6180.876382472416, 6195.690215489208, 6201.81394558164, 5939.732712027969, 5939.940600593939, 5946.43508866657, 5949.791757288474, 5980.730867110903, 6031.819045428644, 6037.09443583466, 6039.698015099228, 6042.184305118841, 6044.425779550936, 5848.444397782204, 5928.851778705481, 5954.225950626391, 5990.041593345044, 6007.30915944672, 5940.31686356066, 5975.43233392827, 5980.790672326448, 5986.982213023796, 5990.311114221833, 4513.413256276663, 4541.364209010741, 4541.364209010741, 4546.1589605922345, 4572.88567785808, 4009.558948515661, 4031.596840315945, 4033.899152521152, 4048.473698419187, 4099.221147981874, 5586.888262234733, 5631.943680563224, 5670.149477578396, 5702.2301989231755, 5764.020116580192, 6125.571210015256, 6133.3866613338305, 6141.416565426277, 6145.8156255312415, 6151.292601350812, 5531.723413829292, 5705.771769129188, 5742.54059675225, 5746.051901436216, 5773.422657734277, 5165.457626949192, 5184.766685499161, 5197.29836472079, 5202.193659982709, 5211.687298762086, 6241.126242326078, 6247.312795592481, 6250.218722659668, 6254.562180647402, 6257.2804127525005, 5844.824655260349, 6031.4270144336215, 6101.877962440726, 6110.205673262448, 6139.048447490646, 6114.0365270920465, 6138.109974053827, 6180.258368995749, 6186.938130618816, 6190.7214175363115, 5950.494207992196, 5950.988331983486, 5953.851153721192, 5960.880782384242, 5986.191864098291, 5825.621334613236, 6073.149759033827, 6082.695865206811, 6117.796956032775, 6133.186900958431, 5903.26209223847, 5943.524518038633, 5978.043513037893, 5988.5508586855285, 5998.550108741949, 5758.740856661377, 5952.494038006818, 5962.493188079062, 5963.642181468952, 5975.0, 5658.688772117573, 5718.485336319751, 5758.769649214152, 5769.596128271149, 5781.5663825214115, 5865.120231965239, 5939.346671866005, 5944.4352786485215, 5949.583529152917, 5967.761289548543, 5617.466340697627, 5769.653820770767, 5810.070388737781, 5818.0, 5818.272715910512], "unit": "score", "name": "dojo.html", "value": 5549.423773583191}, {"lowerIsBetter": false, "replicates": [563.2255648483335, 584.0217635460602, 637.6301744987904, 641.6118248459682, 643.6878114114653, 38599.22801543967, 39221.21557568847, 39222.803885980604, 39322.60677393225, 39337.21325573487, 43039.78480107603, 43491.13017739643, 43649.0, 43704.0, 43732.56267437325, 8762.780930476758, 8886.955565222164, 8922.86615700765, 8953.462792232454, 8966.910330896706, 8817.118288171163, 8934.061923498037, 8944.8658270126, 9161.725148245563, 9173.403728757643, 9049.864252036225, 9155.267578593697, 9166.679166229183, 9167.12912273333, 9181.357304988653, 9043.728688139367, 9095.499747513884, 9128.132827381389, 9136.223421009223, 9160.358774885794, 9038.774030649287, 9142.085791420872, 9161.404508706913, 9177.541122943892, 9190.724278271662, 43422.0, 43928.56071439277, 43964.0, 43970.78014609939, 44008.0, 3173.904782856518, 3762.548494180716, 3866.7486613370043, 3873.4577159197734, 3932.6460618544183, 28912.71087289142, 29891.850540747375, 31658.841705791554, 34047.6595234047, 34378.6562134378, 3795.544534655859, 3840.615938406165, 3918.666913312372, 4043.8382464701376, 4079.714419990602, 207475.0, 208220.0, 209133.0, 209295.0, 209547.0, 66833.6658316715, 66983.0, 67460.32539674638, 67575.66212168908, 67576.6621166891, 73005.6349718248, 76387.0, 76905.23094769093, 76913.61543192249, 77267.61366193133, 17369.652606948042, 17402.564935876704, 17490.825091749175, 17501.037442940506, 17541.0, 13418.396172172275, 13533.86466135326, 13564.389602467912, 13664.453421863212, 13667.521636742866, 22127.33617991463, 22503.212387566684, 22550.32349029532, 22600.434989125075, 22801.429964251027, 8457.534835584102, 8544.18830211129, 8598.78503037429, 8607.870881936777, 8623.396362254582, 1102.6802227353978, 1117.8323251512338, 1134.2797323699344, 1137.6188976692736, 1179.563561482257, 26918.32704182372, 27288.317792055357, 27579.0, 27664.58503122455, 28057.859710701723, 1154.2555051991587, 1159.0553698735503, 1181.2676140792764, 1182.9062559270044, 1234.5247079874314, 14245.287735613385, 14801.056505045455, 14841.109533428029, 14948.103113813206, 15000.474983375529, 411140.0, 751580.0, 760063.0, 767873.0, 769339.0, 61451.0, 62312.0, 62734.0, 62929.0, 62969.370306296354, 1523.4667866246946, 1538.6230373558326, 1546.636540413002, 1548.1794648836135, 1564.9530514084595, 30753.0, 31317.686823131477, 31870.52194217135, 32083.372658496894, 32242.0, 48651.5134848647, 49442.25836612382, 49525.0, 49776.25335619896, 49899.25151122809, 263399.0, 269825.0, 270769.0, 271073.0, 331244.0, 34879.82560087183, 34979.47530787091, 35238.82380588183, 35321.116972075906, 35345.29309413849, 45068.77465612651, 45843.770781147214, 46022.53977460183, 46408.53591464042, 46469.302960454945, 38610.613893860704, 38617.42073868838, 38732.41901371538, 39039.41440878333, 39244.215115696956, 37803.432948505244, 43299.567004329554, 47298.29052564283, 47542.0, 48036.7598162007, 39738.60261397349, 42743.786281068395, 42813.35779963241, 42926.570734293506, 43370.78314608407, 35242.82378588091, 36861.63138368582, 37116.0, 37793.62206377901, 37822.0, 25728.871355643103, 25947.740522594533, 25990.61014084828, 26144.34639134037, 26276.605850912634], "unit": "score", "name": "ext.html", "value": 20298.82229019194}, {"lowerIsBetter": false, "replicates": [383.8121015457159, 386.26031150347086, 389.1167050794695, 390.7284437316063, 393.6024615138709, 17675.381361652344, 18484.445466636007, 19194.520136996583, 19243.711344329848, 19255.71116433251, 17779.55551111223, 17830.910845445756, 18526.351577694782, 18601.720974185366, 18606.534836629093, 4285.657147428198, 5645.802396916109, 5764.7982320618785, 5771.365149833515, 5783.421657834225, 6198.969005154968, 6477.611343319416, 6496.740130394778, 6498.772542960997, 6501.739930402779, 5496.780128794843, 5774.884502309972, 6404.071409645599, 6423.421892029716, 6449.097126402307, 5677.091665333527, 5677.489025987639, 5695.658260504362, 5706.543476521868, 5720.056190728525, 5387.299651045339, 5415.972920135414, 5417.349918009864, 5486.91769623456, 5509.449055094458, 14031.579052628438, 14109.365078571489, 14125.293735313193, 14351.712965740626, 17184.312627494885, 2249.865008099503, 2374.8456350337174, 2557.1433569754154, 2868.1108856254627, 2876.2953076496183, 9884.209263258923, 9965.601375944954, 10183.185345172442, 10769.0, 10914.290571112851, 1892.3660573707825, 1924.5477312831474, 1947.6591596470562, 1956.774970878353, 1993.7906519815356, 65781.0, 66027.33972660308, 67068.66465667641, 67300.6634966822, 68909.96635050428, 10029.69910902674, 10246.282760206714, 10487.265891387682, 10601.469926503643, 10922.1808364373, 14953.252337383088, 15080.698386032438, 15212.923935380251, 15253.23733813327, 15271.236438178046, 7816.983792106989, 8026.157253488416, 8051.154628764012, 8076.919230807616, 8134.471259368122, 7389.852202956018, 7439.107307123179, 7491.063617047869, 7604.923950760422, 7892.881606775903, 4655.906881862344, 4663.347131401607, 4736.95263047372, 4837.588804951619, 4864.683795553277, 1946.143696773415, 1982.3061928324971, 1987.145527423193, 2004.5890592428518, 2013.3054096336741, 941.2422999485343, 1038.138126170644, 1063.170726833056, 1066.7675053860826, 1085.9837102443469, 17029.744553831704, 17115.86551819948, 17379.913100434416, 17828.197731102133, 17833.643327133384, 1017.0897047142765, 1048.9055984961237, 1052.831546952484, 1069.2141276162015, 1079.3092420850662, 8749.518776467356, 10051.899481005097, 10158.644447444303, 10200.0, 10327.225458090674, 428617.0, 430015.0, 438006.0, 439141.0, 441253.0, 79515.60242198753, 80478.59760701277, 81016.18983810204, 81358.0, 81698.0, 993.215359865698, 1005.0803514784037, 1009.4094954451728, 1021.3718563083798, 1061.0768631290825, 15829.0, 15955.361785528448, 15986.440474583798, 16001.679966400374, 16012.359505619645, 36486.27027459489, 37561.4365784508, 37633.0, 38553.80723096366, 39263.41104883486, 47642.0, 48132.79668008328, 50093.24860127174, 50749.0, 51775.74112129415, 8501.787455313666, 8687.087855775053, 8751.64993400257, 8783.253423459077, 8808.779780505538, 11493.942530287295, 12322.383880806103, 12650.746985060432, 13048.478060877458, 13142.211467311992, 10802.351858888493, 10952.123830093415, 10992.340459572451, 11096.778064438828, 11190.66428007161, 10064.647737329451, 10224.795504090025, 10729.570817167227, 10856.13150947938, 11378.943105284421, 10640.0, 10656.360618362924, 10714.303570267908, 10726.785464290515, 10874.836877447004, 8235.176482351717, 8395.916040839513, 8455.069942306465, 8489.957550212457, 8679.435836670596, 11059.83410248863, 12044.277343359427, 12135.211211271238, 12166.666666666666, 12186.268823870596], "unit": "score", "name": "jquery.html", "value": 8836.949015452283}, {"lowerIsBetter": false, "replicates": [1631.8041834979804, 1650.6451113010703, 1913.2825190553533, 1927.2098439639751, 1992.0637300468784, 8475.067742548315, 8530.70142545011, 8650.0, 8689.73930782076, 8720.040795512488, 8648.91351086489, 8691.043985161627, 8694.39139260252, 8723.563821808915, 8739.781505462366, 2367.562001029806, 2383.4041489627593, 2383.666286719852, 2389.7371289158177, 2395.9041638334447, 2394.0423830467867, 2426.162973774045, 2460.8646524441147, 2463.692038495188, 2465.494573612405, 2417.2627348658652, 2430.0887167312258, 2441.2066078524463, 2450.0812195426715, 2451.3626457121186, 2427.6965379327585, 2438.878056097197, 2441.633754936756, 2444.9511009779794, 2461.778439940414, 2446.3394883381566, 2462.3597864555345, 2480.925572232818, 2481.2060140754966, 2483.5902076157413, 8689.652413903435, 8733.257673097794, 8737.475751454933, 8753.562321883945, 8756.168164024408, 5330.893382132374, 5432.076546987022, 5439.5104440600535, 5451.454854514517, 5456.7544460499375, 3185.9203519911957, 3198.696123868252, 3250.4474239379124, 3264.951025734616, 3284.4088064148445, 932.2821427500854, 939.4175611121149, 939.793245485992, 940.7036783413203, 969.471637957315, 12349.93825030878, 12383.504659813687, 12432.316222607753, 12448.502059917593, 12458.626241212778, 4431.468223813099, 4496.865094047118, 4522.050369422458, 4552.317152427162, 4585.770711464414, 9773.364731292444, 9794.118529332252, 9801.460919649346, 9803.656872009446, 9812.607495700235, 5284.3658760948165, 5302.337207849019, 5304.893902121936, 5312.548433383128, 5326.840194794162, 4197.097624010852, 4778.832740854054, 4818.590419814285, 4832.323474713543, 4844.273358996179, 3722.16251343451, 3736.103335199587, 3742.045778326564, 3815.6947444204397, 3833.290841194388, 1123.9269447485888, 1125.5160281079216, 1134.2173900008968, 1137.7098839795965, 1137.9487923043482, 1156.9537218511334, 1176.3236139219982, 1178.0634395655475, 1220.6582156996055, 1245.4520011195045, 8128.0, 8212.219839115274, 8280.0, 8280.668773249123, 8323.458975166715, 1142.628645690154, 1197.7963746163173, 1234.802241825428, 1239.5599562155485, 1241.6895776055985, 6473.77341793035, 6488.351164883474, 6575.638339891256, 6584.1440612721, 6594.7032383542855, 9946.055124763136, 10280.897191028143, 10293.0, 10369.325993810378, 10415.375077495375, 10082.092611664986, 10120.797584048278, 10269.075783179549, 10331.94834025825, 10367.481625918674, 8307.501549907025, 8365.958170209231, 8385.287250583646, 8391.035030971394, 8470.15298470148, 7916.327112195528, 7983.760487185394, 7988.560629165451, 8067.1529489402765, 8093.919060809317, 9438.669646562337, 9477.573509191965, 9547.0, 9552.092551207903, 9558.187554057982, 9781.021897810162, 9916.603335866484, 9952.203823694232, 10019.398836069568, 10152.847707284544, 5928.110783382354, 6904.240533541407, 7097.077379940574, 7112.928870711226, 7181.964090179516, 8307.584620768817, 8342.83314333722, 8344.916550834414, 8353.0811610724, 8409.83180336402, 7189.460790440633, 7261.273872612696, 7299.0, 7353.852922941618, 7434.182239953492, 7272.381847543018, 7276.163241227115, 7307.488475806856, 7360.0, 7535.660895259617, 7830.725924592612, 7847.0975837777105, 7854.72508462224, 7879.172686867796, 7889.408294377829, 7175.497715159889, 7252.492325537372, 7256.020437240905, 7261.673224704795, 7327.413806895329, 7237.059182306267, 7279.636018199175, 7300.707971681073, 7311.634418279171, 7326.560406375635], "unit": "score", "name": "mootools.html", "value": 4891.687883932277}, {"lowerIsBetter": false, "replicates": [328.1582740271203, 333.2784521510929, 333.72134267886315, 336.36595018390335, 338.6985582831279, 6335.9366406335985, 6405.775797847076, 6406.551541392105, 6422.0, 6423.64669943153, 6362.14111095002, 6364.554481186319, 6382.648954307511, 6440.194975628046, 6455.709493072823, 4639.652026098056, 4769.070031343889, 4800.783964721579, 4810.759462026894, 4814.73518956459, 4796.5443282888245, 4805.6155507559315, 4805.711657300573, 4822.397200349957, 4832.73419961902, 4761.59526440253, 4768.260919557457, 4768.713877167381, 4776.28355746639, 4782.665213435061, 4783.736894470802, 4791.161546729309, 4802.327674125625, 4806.231003039515, 4806.879828004293, 4145.316022856225, 4150.252954468195, 4158.37624356346, 4158.521769996459, 4163.479565054368, 6044.667543285118, 6065.848353791191, 6066.878662426727, 6070.6357618543025, 6072.908906366408, 5341.866453338697, 5497.065498865202, 5529.253550770634, 5529.557635389199, 5536.612437129403, 6735.663216839187, 6745.3591908768585, 6753.3921947025, 6755.432935484484, 6760.904119722853, 4508.954910450886, 4510.458744950594, 4513.909721805546, 4515.819367225307, 4526.728396296233, 6968.407685346701, 7043.401310888581, 7082.681279342442, 7084.14990201174, 7084.14990201174, 4577.0, 4670.206064968964, 4678.8128474861305, 4684.156851766715, 4691.483936766953, 4680.15757163707, 4709.27006314015, 4716.127516409407, 4718.9292160617615, 4726.220173671374, 5491.560675145979, 5530.917036244459, 5531.529819965268, 5533.418991005967, 5541.5289700375115, 6814.557053791487, 6857.177138743383, 6858.142732158481, 6868.210155832044, 6873.0, 1634.7466142747894, 1680.9411670591714, 1681.756145358916, 1682.9747553786704, 1687.0889719551305, 1051.0540513537876, 1082.2478377527543, 1085.5006696919506, 1086.9021788039115, 1087.1574529739514, 6394.552381333262, 6404.615723056539, 6406.071119687619, 6411.775587854403, 6508.576942498722, 7020.543664661781, 7025.859482810315, 7032.789016329519, 7034.929650703428, 7040.929590704028, 6339.11252424661, 6429.45349645276, 6532.118164047888, 6589.077529145923, 6594.175728033996, 3816.8282427290837, 3825.5600605930676, 3841.7310788244554, 3842.51968503937, 3849.576546579874, 7299.41604671625, 7309.817254568678, 7317.634118294064, 7322.121345438475, 7322.853542929111, 7258.637068146571, 7281.635918204069, 7286.599237042014, 7294.927050729425, 7303.160136584361, 6986.371226589631, 7295.89056164158, 7299.70801167958, 7301.890471643036, 7311.3785328247695, 7036.120484939383, 7059.541129826544, 7076.787696369117, 7084.539504932163, 7088.113985751781, 6955.374016338554, 6959.930400695928, 6979.40675042627, 6982.615956122462, 6986.476014298846, 7282.271772822675, 7282.927170728225, 7287.234840341688, 7287.672054757655, 7313.48805583604, 4492.505824359383, 4624.953750462452, 4638.141943740419, 4641.466231383434, 4701.694389864648, 6999.160100787938, 7031.718731250693, 7050.541714788523, 7057.505974581935, 7076.787696368911, 6807.89788153188, 6817.113775209389, 6818.556793808387, 6827.0, 6827.590344579341, 6796.626185559841, 6800.863982720417, 6805.251422343637, 6808.421284190899, 6809.114815074008, 6522.706478208397, 6697.866042679217, 6720.1599800025, 6736.562123461959, 6738.191417029988, 6820.35206655367, 6848.520603557703, 6858.0, 6868.244493105654, 6898.379145876896, 6758.628275444898, 6771.830704232237, 6774.695138718671, 6774.762883299061, 6789.72841086351], "unit": "score", "name": "prototype.html", "value": 5067.0907007262595}, {"lowerIsBetter": false, "replicates": [723.2333726250175, 730.8647900138471, 791.6591981836648, 847.737201467545, 890.3589415620751, 14695.0, 15017.474388396395, 15194.620134496628, 15376.846231537682, 15699.450519231828, 16389.42637007705, 16406.589835254126, 16409.261583228752, 16409.671806563863, 16554.420595279167, 937.4188003437878, 943.1558754914347, 950.4724877692878, 955.0497255231055, 962.5427921737154, 948.6964171465133, 960.9711708648716, 961.8990006049369, 962.3071388600197, 965.3049804141042, 990.782027953849, 1003.5534187286661, 1006.9194464442827, 1008.374807619277, 1009.4952523738131, 984.5963155106408, 985.8521221816713, 990.2424645146468, 991.8760154980628, 995.3679413572361, 732.1543617122232, 735.6174789109687, 735.731458017825, 736.4403053679189, 736.5507040705165, 15521.45674901373, 15561.066336019874, 15587.922060389625, 15606.219689015505, 15609.297581608742, 13071.346432678423, 13196.14225075367, 13209.603711888658, 13528.18830870141, 13565.118267312593, 11216.270942388719, 11382.0, 11391.259568128045, 11528.250663706833, 11559.94220028903, 3683.0608194910396, 3697.7041836653, 3725.795081270529, 3727.2172843702856, 3729.757565758217, 52876.0, 52926.0, 54455.0, 54533.18200227, 54857.72571137159, 10338.896611033793, 10415.947920260502, 10551.261411701107, 10565.735856603493, 10650.573977040987, 17435.912820435817, 17589.7361539577, 17656.646867062587, 17661.116944152996, 17720.734188987175, 7545.320921117126, 7743.4966727162555, 7745.728899488491, 7891.960540197262, 8014.255507132703, 4395.780210989437, 4534.501204867462, 4589.128065667513, 4602.585767280961, 4656.580907718321, 3494.8776792812127, 3520.436730123219, 3527.700145487611, 3532.8586856525453, 3546.680798728127, 589.1222079102107, 598.9191459153046, 601.5849064145725, 603.4177019176516, 606.6147996022469, 692.3388164303078, 723.5767076260341, 741.8442127153359, 751.1136858507015, 752.7177308509309, 8890.911090889138, 9131.954340228256, 9135.269178465707, 9136.58885350161, 9205.125513076247, 637.0571554099959, 651.9047999361119, 672.3612568060264, 734.904462419882, 736.2747693521877, 4015.8996025099605, 4185.121124563815, 4335.3063509838275, 4492.348609451677, 4539.6368290536675, 57342.7132864333, 57374.426255737744, 57487.0, 57842.0, 58453.41546584565, 52031.47968520342, 53035.20447193218, 53930.46069539255, 59680.70159649174, 60063.69968150131, 46845.531544684796, 47867.52132478631, 48005.279920801215, 48334.758326208146, 48600.7569962155, 9541.618335266512, 9584.185344245818, 9634.506651469033, 9798.510074496104, 9823.803523929624, 35097.64902350944, 37711.434328484545, 38458.61541384662, 38773.22453550857, 38870.83387498379, 42910.78544607257, 43076.0, 43659.78170109129, 43769.0, 44132.0, 12129.80356974681, 12496.312702801433, 12564.37178141071, 12613.747725045265, 12719.300438475602, 12703.0, 12767.74464510686, 13776.586702398945, 13801.140590131416, 14113.929430352782, 12750.48998040068, 12815.935920320711, 12935.094543381872, 13139.408726607135, 13209.801852972021, 12658.493660253487, 12695.55565555201, 12755.553555625509, 12845.100842940905, 12874.613761587167, 12441.564545240873, 12692.36538173106, 12776.425060872469, 12895.935520322339, 13300.600981970556, 10375.584976600852, 10553.788924221626, 10782.892171078503, 10817.134629229486, 10870.510827012962, 10747.731306717395, 10832.5125369357, 10921.0, 10932.890671093188, 10963.122950164126], "unit": "score", "name": "yui.html", "value": 6921.095145299494}], "name": "dromaeo_css", "value": 7448.604573602662}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 103.0, 111.0, 110.0, 113.0, 100.0, 112.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 154.0, 159.0, 127.0, 155.0, 160.0, 131.0, 169.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 163.0, 163.0, 165.0, 164.0, 162.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [76.0, 79.0, 74.0, 164.0, 76.0, 74.0, 75.0, 73.0, 176.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.3}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 151.0, 93.0, 92.0, 94.0, 142.0, 92.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 56.0, 60.0, 56.0, 58.0, 57.0, 65.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 80.0, 80.0, 78.0, 77.0, 78.0, 79.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [118.0, 113.0, 116.0, 111.0, 111.0, 124.0, 121.0, 114.0, 113.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.6}, {"lowerIsBetter": true, "replicates": [135.0, 141.0, 138.0, 140.0, 128.0, 143.0, 133.0, 137.0, 141.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.6}, {"lowerIsBetter": true, "replicates": [71.0, 67.0, 69.0, 65.0, 69.0, 66.0, 68.0, 65.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1502.2999999999997}]} 22:43:06 INFO - Return code: 0 22:43:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:43:06 ERROR - # TBPL SUCCESS # 22:43:06 INFO - Running post-action listener: _resource_record_post_action 22:43:06 INFO - Running post-run listener: _resource_record_post_run 22:43:07 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 16384; Write bytes: 456880128; Read time: 36; Write time: 736304 22:43:07 INFO - install - Wall time: 13s; CPU: 17.0%; Read bytes: 0; Write bytes: 233897984; Read time: 0; Write time: 514508 22:43:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 16384; Write bytes: 218587136; Read time: 36; Write time: 221044 22:43:07 INFO - Running post-run listener: _upload_blobber_files 22:43:07 INFO - Blob upload gear active. 22:43:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:43:07 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 22:43:07 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:43:07 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:43:07 INFO - (blobuploader) - INFO - Open directory for files ... 22:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:09 INFO - (blobuploader) - INFO - Done attempting. 22:43:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:43:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:43:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:43:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:43:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:43:09 INFO - (blobuploader) - INFO - Done attempting. 22:43:09 INFO - (blobuploader) - INFO - Iteration through files over. 22:43:09 INFO - Return code: 0 22:43:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:43:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:43:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f112b7c76ac86fc523b3223aec7dfc23b78bcb74cf1df854f8477d0773814e9e0b46196cabddc767fe02eec9a1cfd3aa98c9196a62ffaf3fa96b8ab1841aba05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee85664088d4acd195e26a93617b4cea75069d4dbf206cdf0dfb6f31376540033548e0fea710b3605808b8045f5c84d817a1bf02c16967cb5eaad9c65c9d2b87"} 22:43:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:43:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:43:09 INFO - Contents: 22:43:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f112b7c76ac86fc523b3223aec7dfc23b78bcb74cf1df854f8477d0773814e9e0b46196cabddc767fe02eec9a1cfd3aa98c9196a62ffaf3fa96b8ab1841aba05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee85664088d4acd195e26a93617b4cea75069d4dbf206cdf0dfb6f31376540033548e0fea710b3605808b8045f5c84d817a1bf02c16967cb5eaad9c65c9d2b87"} 22:43:09 INFO - Running post-run listener: copy_logs_to_upload_dir 22:43:09 INFO - Copying logs to upload dir... 22:43:09 INFO - mkdir: /builds/slave/test/build/upload/logs 22:43:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.652173 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-25 22:43:09.903910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 22:43:09.907911) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679 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-Beta/sha512/f112b7c76ac86fc523b3223aec7dfc23b78bcb74cf1df854f8477d0773814e9e0b46196cabddc767fe02eec9a1cfd3aa98c9196a62ffaf3fa96b8ab1841aba05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee85664088d4acd195e26a93617b4cea75069d4dbf206cdf0dfb6f31376540033548e0fea710b3605808b8045f5c84d817a1bf02c16967cb5eaad9c65c9d2b87"} build_url:https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/UWAb1ymhTnSQgzIVLbuwfQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f112b7c76ac86fc523b3223aec7dfc23b78bcb74cf1df854f8477d0773814e9e0b46196cabddc767fe02eec9a1cfd3aa98c9196a62ffaf3fa96b8ab1841aba05", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee85664088d4acd195e26a93617b4cea75069d4dbf206cdf0dfb6f31376540033548e0fea710b3605808b8045f5c84d817a1bf02c16967cb5eaad9c65c9d2b87"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 22:43:09.933898) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:43:09.934297) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464239915.31235-1228185679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 22:43:10.019583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 22:43:10.019916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 22:43:10.020252) ========= ========= Total master_lag: 0.19 =========