builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1475573561.54 results: success (0) buildid: 20161004010500 builduid: 688487d8508e418baf88cd0ad7664e57 revision: 4a938cf41515d9d1a952a6e454b6ac6d9a6c6877 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.535682) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.536258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.536592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.560663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.560998) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 02:32:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-10-04 02:32:42 (39.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085760 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.676956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.677291) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018345 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.730932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:41.731294) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4a938cf41515d9d1a952a6e454b6ac6d9a6c6877 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4a938cf41515d9d1a952a6e454b6ac6d9a6c6877 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 02:32:42,695 truncating revision to first 12 chars 2016-10-04 02:32:42,695 Setting DEBUG logging. 2016-10-04 02:32:42,695 attempt 1/10 2016-10-04 02:32:42,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4a938cf41515?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 02:32:43,066 unpacking tar archive at: autoland-4a938cf41515/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:42.467166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:42.467902) ========= script_repo_revision: 4a938cf41515d9d1a952a6e454b6ac6d9a6c6877 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:42.468803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:42.469500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 02:32:42.482375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 02:32:42.483099) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:32:43 INFO - MultiFileLogger online at 20161004 02:32:43 in /builds/slave/test 02:32:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 02:32:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:43 INFO - {'append_to_log': False, 02:32:43 INFO - 'base_work_dir': '/builds/slave/test', 02:32:43 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 02:32:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:43 INFO - 'branch': 'Autoland-Non-PGO', 02:32:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:43 INFO - 'config_files': ('talos/linux_config.py',), 02:32:43 INFO - 'default_actions': ('clobber', 02:32:43 INFO - 'read-buildbot-config', 02:32:43 INFO - 'download-and-extract', 02:32:43 INFO - 'populate-webroot', 02:32:43 INFO - 'create-virtualenv', 02:32:43 INFO - 'install', 02:32:43 INFO - 'run-tests'), 02:32:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:43 INFO - 'download_minidump_stackwalk': True, 02:32:43 INFO - 'download_symbols': 'ondemand', 02:32:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:43 INFO - 'installer_path': 'installer.exe', 02:32:43 INFO - 'log_level': 'info', 02:32:43 INFO - 'log_name': 'talos', 02:32:43 INFO - 'log_to_console': True, 02:32:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:32:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:32:43 INFO - 'opt_config_files': (), 02:32:43 INFO - 'pip_index': False, 02:32:43 INFO - 'sps_profile': False, 02:32:43 INFO - 'sps_profile_interval': 0, 02:32:43 INFO - 'suite': 'dromaeojs', 02:32:43 INFO - 'system_bits': '32', 02:32:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:43 INFO - 'title': 'talos-linux64-ix-069', 02:32:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:43 INFO - 'use_talos_json': True, 02:32:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:43 INFO - 'work_dir': 'build'} 02:32:43 INFO - [mozharness: 2016-10-04 09:32:43.539729Z] Running clobber step. 02:32:43 INFO - Running pre-action listener: _resource_record_pre_action 02:32:43 INFO - Running main action method: clobber 02:32:43 INFO - rmtree: /builds/slave/test/build 02:32:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:44 INFO - Running post-action listener: _resource_record_post_action 02:32:44 INFO - [mozharness: 2016-10-04 09:32:44.523889Z] Finished clobber step (success) 02:32:44 INFO - [mozharness: 2016-10-04 09:32:44.523989Z] Running read-buildbot-config step. 02:32:44 INFO - Running pre-action listener: _resource_record_pre_action 02:32:44 INFO - Running main action method: read_buildbot_config 02:32:44 INFO - Using buildbot properties: 02:32:44 INFO - { 02:32:44 INFO - "project": "", 02:32:44 INFO - "product": "firefox", 02:32:44 INFO - "script_repo_revision": "production", 02:32:44 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 02:32:44 INFO - "repository": "", 02:32:44 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 02:32:44 INFO - "buildid": "20161004010500", 02:32:44 INFO - "pgo_build": "False", 02:32:44 INFO - "basedir": "/builds/slave/test", 02:32:44 INFO - "buildnumber": 763, 02:32:44 INFO - "slavename": "talos-linux64-ix-069", 02:32:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:32:44 INFO - "platform": "ubuntu64_hw", 02:32:44 INFO - "scheduler": "tests-autoland-linux64-talos", 02:32:44 INFO - "branch": "autoland", 02:32:44 INFO - "repo_path": "integration/autoland", 02:32:44 INFO - "revision": "4a938cf41515d9d1a952a6e454b6ac6d9a6c6877", 02:32:44 INFO - "stage_platform": "linux64", 02:32:44 INFO - "builduid": "688487d8508e418baf88cd0ad7664e57", 02:32:44 INFO - "slavebuilddir": "test" 02:32:44 INFO - } 02:32:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:32:44 INFO - Running post-action listener: _resource_record_post_action 02:32:44 INFO - [mozharness: 2016-10-04 09:32:44.526416Z] Finished read-buildbot-config step (success) 02:32:44 INFO - [mozharness: 2016-10-04 09:32:44.526504Z] Running download-and-extract step. 02:32:44 INFO - Running pre-action listener: _resource_record_pre_action 02:32:44 INFO - Running main action method: download_and_extract 02:32:44 INFO - mkdir: /builds/slave/test/build/tests 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:44 INFO - trying https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:32:44 INFO - Downloading https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:32:45 INFO - Downloaded 1361 bytes. 02:32:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:32:45 INFO - Using the following test package requirements: 02:32:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:32:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:32:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'jsshell-linux-x86_64.zip'], 02:32:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:32:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:32:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:32:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:32:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:32:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:32:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:32:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:45 INFO - Fetch https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:32:45 INFO - Http code: 200 02:32:45 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 02:32:45 INFO - x-amz-cf-id: GiT1FIhi9Nrtl1LPJyN6HmdcfpmxBwqUcYE2GUBI4Hr2OFGZFzGdFQ== 02:32:45 INFO - x-amz-version-id: MKMRwwG8URwDr51WECAu4FfQ5vAKWeHK 02:32:46 INFO - Expected file size: 20420957 02:32:46 INFO - Obtained file size: 20420957 02:32:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:32:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:32:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:32:50 INFO - Fetch https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:32:51 INFO - Http code: 200 02:32:51 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 02:32:51 INFO - x-amz-cf-id: smve1KtFRhDwq1i8z4NA0HcJvqDX93AmEcWYFItRxSUvZJkFtKpLMQ== 02:32:51 INFO - x-amz-version-id: MKMRwwG8URwDr51WECAu4FfQ5vAKWeHK 02:32:51 INFO - Expected file size: 20420957 02:32:51 INFO - Obtained file size: 20420957 02:32:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:32:55 INFO - Fetch https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:32:56 INFO - Http code: 200 02:32:56 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 02:32:56 INFO - x-amz-cf-id: ytBu_ZAQy2pLmv0aB_ogvaxtLKsebxC1fsF550pJ8WybxGprZUT2ig== 02:32:56 INFO - x-amz-version-id: 087XjYhccDxgjKGdopn3lhxjIunt56IZ 02:32:57 INFO - Expected file size: 14408522 02:32:57 INFO - Obtained file size: 14408522 02:32:57 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:57 INFO - trying https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:57 INFO - Downloading https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:32:59 INFO - Downloaded 55789283 bytes. 02:32:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:32:59 INFO - mkdir: /builds/slave/test/properties 02:32:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:59 INFO - Contents: 02:32:59 INFO - build_url:https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:33:00 INFO - Running post-action listener: _resource_record_post_action 02:33:00 INFO - Running post-action listener: set_extra_try_arguments 02:33:00 INFO - [mozharness: 2016-10-04 09:33:00.098669Z] Finished download-and-extract step (success) 02:33:00 INFO - [mozharness: 2016-10-04 09:33:00.098932Z] Running populate-webroot step. 02:33:00 INFO - Running pre-action listener: _resource_record_pre_action 02:33:00 INFO - Running main action method: populate_webroot 02:33:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:33:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:33:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:33:00 INFO - '--tppagecycles', 02:33:00 INFO - '7'], 02:33:00 INFO - 'tests': ['tsvgm']}}, 02:33:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:33:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:33:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:33:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:33:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:33:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['damp', 'tps']}, 02:33:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'tests': ['damp', 'tps']}, 02:33:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['dromaeo_dom']}, 02:33:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:33:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['basic_compositor_video']}, 02:33:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:33:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['a11yr', 02:33:00 INFO - 'ts_paint', 02:33:00 INFO - 'tpaint', 02:33:00 INFO - 'sessionrestore', 02:33:00 INFO - 'sessionrestore_no_auto_restore', 02:33:00 INFO - 'tabpaint']}, 02:33:00 INFO - 'other-e10s': {'tests': ['a11yr', 02:33:00 INFO - 'ts_paint', 02:33:00 INFO - 'tpaint', 02:33:00 INFO - 'sessionrestore', 02:33:00 INFO - 'sessionrestore_no_auto_restore', 02:33:00 INFO - 'tabpaint']}, 02:33:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:33:00 INFO - 'ts_paint', 02:33:00 INFO - 'tpaint', 02:33:00 INFO - 'sessionrestore', 02:33:00 INFO - 'sessionrestore_no_auto_restore', 02:33:00 INFO - 'tabpaint']}, 02:33:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:33:00 INFO - 'ts_paint', 02:33:00 INFO - 'tpaint', 02:33:00 INFO - 'sessionrestore', 02:33:00 INFO - 'sessionrestore_no_auto_restore', 02:33:00 INFO - 'tabpaint']}, 02:33:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['a11yr', 02:33:00 INFO - 'ts_paint', 02:33:00 INFO - 'tpaint', 02:33:00 INFO - 'sessionrestore', 02:33:00 INFO - 'sessionrestore_no_auto_restore', 02:33:00 INFO - 'tabpaint']}, 02:33:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['a11yr', 02:33:00 INFO - 'ts_paint', 02:33:00 INFO - 'tpaint', 02:33:00 INFO - 'sessionrestore', 02:33:00 INFO - 'sessionrestore_no_auto_restore', 02:33:00 INFO - 'tabpaint']}, 02:33:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['tsvgx', 02:33:00 INFO - 'tsvgr_opacity', 02:33:00 INFO - 'tart', 02:33:00 INFO - 'tscrollx', 02:33:00 INFO - 'cart']}, 02:33:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:33:00 INFO - 'tsvgr_opacity', 02:33:00 INFO - 'tart', 02:33:00 INFO - 'tscrollx', 02:33:00 INFO - 'cart']}, 02:33:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'talos_options': ['--disable-e10s'], 02:33:00 INFO - 'tests': ['tp5o']}, 02:33:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'tests': ['tp5o']}, 02:33:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'talos_options': ['--disable-e10s', 02:33:00 INFO - '--xperf_path', 02:33:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:00 INFO - 'tests': ['tp5n']}, 02:33:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:33:00 INFO - 'talos_options': ['--xperf_path', 02:33:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:33:00 INFO - 'tests': ['tp5n']}}, 02:33:00 INFO - 'talos.zip': {'path': '', 02:33:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:33:00 INFO - Running post-action listener: _resource_record_post_action 02:33:00 INFO - [mozharness: 2016-10-04 09:33:00.114694Z] Finished populate-webroot step (success) 02:33:00 INFO - [mozharness: 2016-10-04 09:33:00.114801Z] Running create-virtualenv step. 02:33:00 INFO - Running pre-action listener: _resource_record_pre_action 02:33:00 INFO - Running main action method: create_virtualenv 02:33:00 INFO - Creating virtualenv /builds/slave/test/build/venv 02:33:00 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 02:33:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:33:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:33:00 INFO - Using real prefix '/usr' 02:33:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:33:00 INFO - Installing distribute.............................................................................................................................................................................................done. 02:33:02 INFO - Installing pip.................done. 02:33:02 INFO - Return code: 0 02:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:33:02 INFO - Reading from file tmpfile_stdout 02:33:02 INFO - Output received: 02:33:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:33:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33: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', 'pip>=1.5'] in /builds/slave/test/build 02:33: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 pip>=1.5 02:33:02 INFO - Using env: {'DISPLAY': ':0', 02:33:02 INFO - 'HOME': '/home/cltbld', 02:33:02 INFO - 'LANG': 'en_US.UTF-8', 02:33:02 INFO - 'LANGUAGE': 'en_US:en', 02:33:02 INFO - 'LOGNAME': 'cltbld', 02:33:02 INFO - 'MAIL': '/var/mail/cltbld', 02:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:02 INFO - 'MOZ_NO_REMOTE': '1', 02:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:02 INFO - 'NO_EM_RESTART': '1', 02:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:02 INFO - 'PWD': '/builds/slave/test', 02:33:02 INFO - 'SHELL': '/bin/bash', 02:33:02 INFO - 'SHLVL': '1', 02:33:02 INFO - 'TERM': 'linux', 02:33:02 INFO - 'TMOUT': '86400', 02:33:02 INFO - 'USER': 'cltbld', 02:33:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:02 INFO - '_': '/tools/buildbot/bin/python'} 02:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:03 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 02:33:03 INFO - Cleaning up... 02:33:03 INFO - Return code: 0 02:33:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:33:03 INFO - Using env: {'DISPLAY': ':0', 02:33:03 INFO - 'HOME': '/home/cltbld', 02:33:03 INFO - 'LANG': 'en_US.UTF-8', 02:33:03 INFO - 'LANGUAGE': 'en_US:en', 02:33:03 INFO - 'LOGNAME': 'cltbld', 02:33:03 INFO - 'MAIL': '/var/mail/cltbld', 02:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:03 INFO - 'MOZ_NO_REMOTE': '1', 02:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:03 INFO - 'NO_EM_RESTART': '1', 02:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:03 INFO - 'PWD': '/builds/slave/test', 02:33:03 INFO - 'SHELL': '/bin/bash', 02:33:03 INFO - 'SHLVL': '1', 02:33:03 INFO - 'TERM': 'linux', 02:33:03 INFO - 'TMOUT': '86400', 02:33:03 INFO - 'USER': 'cltbld', 02:33:03 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:03 INFO - '_': '/tools/buildbot/bin/python'} 02:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:03 INFO - Downloading/unpacking psutil>=3.1.1 02:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:33:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:05 INFO - Installing collected packages: psutil 02:33:05 INFO - Running setup.py install for psutil 02:33:05 INFO - building 'psutil._psutil_linux' extension 02:33:05 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 02:33:05 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 02:33:05 INFO - building 'psutil._psutil_posix' extension 02:33:05 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 02:33:05 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 02:33:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:33:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:33:05 INFO - Successfully installed psutil 02:33:05 INFO - Cleaning up... 02:33:05 INFO - Return code: 0 02:33:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:33:05 INFO - Using env: {'DISPLAY': ':0', 02:33:05 INFO - 'HOME': '/home/cltbld', 02:33:05 INFO - 'LANG': 'en_US.UTF-8', 02:33:05 INFO - 'LANGUAGE': 'en_US:en', 02:33:05 INFO - 'LOGNAME': 'cltbld', 02:33:05 INFO - 'MAIL': '/var/mail/cltbld', 02:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:05 INFO - 'MOZ_NO_REMOTE': '1', 02:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:05 INFO - 'NO_EM_RESTART': '1', 02:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SHLVL': '1', 02:33:05 INFO - 'TERM': 'linux', 02:33:05 INFO - 'TMOUT': '86400', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - '_': '/tools/buildbot/bin/python'} 02:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:33:08 INFO - Installing collected packages: mozsystemmonitor 02:33:08 INFO - Running setup.py install for mozsystemmonitor 02:33:08 INFO - Successfully installed mozsystemmonitor 02:33:08 INFO - Cleaning up... 02:33:08 INFO - Return code: 0 02:33:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:33:08 INFO - Using env: {'DISPLAY': ':0', 02:33:08 INFO - 'HOME': '/home/cltbld', 02:33:08 INFO - 'LANG': 'en_US.UTF-8', 02:33:08 INFO - 'LANGUAGE': 'en_US:en', 02:33:08 INFO - 'LOGNAME': 'cltbld', 02:33:08 INFO - 'MAIL': '/var/mail/cltbld', 02:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:08 INFO - 'MOZ_NO_REMOTE': '1', 02:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:08 INFO - 'NO_EM_RESTART': '1', 02:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:08 INFO - 'PWD': '/builds/slave/test', 02:33:08 INFO - 'SHELL': '/bin/bash', 02:33:08 INFO - 'SHLVL': '1', 02:33:08 INFO - 'TERM': 'linux', 02:33:08 INFO - 'TMOUT': '86400', 02:33:08 INFO - 'USER': 'cltbld', 02:33:08 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:08 INFO - '_': '/tools/buildbot/bin/python'} 02:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:33:10 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 02:33:10 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 02:33:10 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 02:33:10 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 02:33:10 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 02:33:10 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 02:33:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:10 INFO - warning: no files found matching '*.txt' 02:33:10 INFO - no previously-included directories found matching 'build' 02:33:10 INFO - no previously-included directories found matching 'dist' 02:33:10 INFO - no previously-included directories found matching '.git*' 02:33:10 INFO - Installing collected packages: jsonschema, functools32 02:33:10 INFO - Running setup.py install for functools32 02:33:10 INFO - warning: no files found matching '*.txt' 02:33:10 INFO - no previously-included directories found matching 'build' 02:33:10 INFO - no previously-included directories found matching 'dist' 02:33:10 INFO - no previously-included directories found matching '.git*' 02:33:10 INFO - Successfully installed jsonschema functools32 02:33:10 INFO - Cleaning up... 02:33:10 INFO - Return code: 0 02:33:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:33:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:10 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:10 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:33:10 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 functools32==3.2.3-2 02:33:10 INFO - Using env: {'DISPLAY': ':0', 02:33:10 INFO - 'HOME': '/home/cltbld', 02:33:10 INFO - 'LANG': 'en_US.UTF-8', 02:33:10 INFO - 'LANGUAGE': 'en_US:en', 02:33:10 INFO - 'LOGNAME': 'cltbld', 02:33:10 INFO - 'MAIL': '/var/mail/cltbld', 02:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:10 INFO - 'MOZ_NO_REMOTE': '1', 02:33:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:10 INFO - 'NO_EM_RESTART': '1', 02:33:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:10 INFO - 'PWD': '/builds/slave/test', 02:33:10 INFO - 'SHELL': '/bin/bash', 02:33:10 INFO - 'SHLVL': '1', 02:33:10 INFO - 'TERM': 'linux', 02:33:10 INFO - 'TMOUT': '86400', 02:33:10 INFO - 'USER': 'cltbld', 02:33:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:10 INFO - '_': '/tools/buildbot/bin/python'} 02:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:33:11 INFO - Cleaning up... 02:33:11 INFO - Return code: 0 02:33:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:33:11 INFO - Using env: {'DISPLAY': ':0', 02:33:11 INFO - 'HOME': '/home/cltbld', 02:33:11 INFO - 'LANG': 'en_US.UTF-8', 02:33:11 INFO - 'LANGUAGE': 'en_US:en', 02:33:11 INFO - 'LOGNAME': 'cltbld', 02:33:11 INFO - 'MAIL': '/var/mail/cltbld', 02:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:11 INFO - 'MOZ_NO_REMOTE': '1', 02:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:11 INFO - 'NO_EM_RESTART': '1', 02:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:11 INFO - 'PWD': '/builds/slave/test', 02:33:11 INFO - 'SHELL': '/bin/bash', 02:33:11 INFO - 'SHLVL': '1', 02:33:11 INFO - 'TERM': 'linux', 02:33:11 INFO - 'TMOUT': '86400', 02:33:11 INFO - 'USER': 'cltbld', 02:33:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:11 INFO - '_': '/tools/buildbot/bin/python'} 02:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:13 INFO - Downloading docopt-0.6.1.tar.gz 02:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:13 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:13 INFO - Running setup.py install for blobuploader 02:33:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:14 INFO - Running setup.py install for requests 02:33:14 INFO - Running setup.py install for docopt 02:33:14 INFO - Successfully installed blobuploader requests docopt 02:33:14 INFO - Cleaning up... 02:33:14 INFO - Return code: 0 02:33:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:14 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 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:14 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 02:33:14 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 02:33:14 INFO - Using env: {'DISPLAY': ':0', 02:33:14 INFO - 'HOME': '/home/cltbld', 02:33:14 INFO - 'LANG': 'en_US.UTF-8', 02:33:14 INFO - 'LANGUAGE': 'en_US:en', 02:33:14 INFO - 'LOGNAME': 'cltbld', 02:33:14 INFO - 'MAIL': '/var/mail/cltbld', 02:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:14 INFO - 'MOZ_NO_REMOTE': '1', 02:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:14 INFO - 'NO_EM_RESTART': '1', 02:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:14 INFO - 'PWD': '/builds/slave/test', 02:33:14 INFO - 'SHELL': '/bin/bash', 02:33:14 INFO - 'SHLVL': '1', 02:33:14 INFO - 'TERM': 'linux', 02:33:14 INFO - 'TMOUT': '86400', 02:33:14 INFO - 'USER': 'cltbld', 02:33:14 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:14 INFO - '_': '/tools/buildbot/bin/python'} 02:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:14 INFO - Running setup.py (path:/tmp/pip-AEpGsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:14 INFO - Running setup.py (path:/tmp/pip-WmPWXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:14 INFO - Running setup.py (path:/tmp/pip-kNWBBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:14 INFO - Running setup.py (path:/tmp/pip-LDxg92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:15 INFO - Running setup.py (path:/tmp/pip-8RUQrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:15 INFO - Running setup.py (path:/tmp/pip-4i6Kt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:15 INFO - Running setup.py (path:/tmp/pip-6c3R6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:15 INFO - Running setup.py (path:/tmp/pip-FRNngC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:15 INFO - Running setup.py (path:/tmp/pip-lG2b59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:15 INFO - Running setup.py (path:/tmp/pip-sZJzGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:15 INFO - Running setup.py (path:/tmp/pip-REfqRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:15 INFO - Running setup.py (path:/tmp/pip-_WPotm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:15 INFO - Running setup.py (path:/tmp/pip-MgPdIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:15 INFO - Running setup.py (path:/tmp/pip-_E70Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:15 INFO - Running setup.py (path:/tmp/pip-92UVnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:15 INFO - Running setup.py (path:/tmp/pip-mn0FWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:15 INFO - Running setup.py (path:/tmp/pip-Y1ffzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:15 INFO - Running setup.py install for manifestparser 02:33:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Running setup.py install for mozcrash 02:33:16 INFO - Running setup.py install for mozdebug 02:33:16 INFO - Running setup.py install for mozdevice 02:33:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Running setup.py install for mozfile 02:33:16 INFO - Running setup.py install for mozhttpd 02:33:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Running setup.py install for mozinfo 02:33:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Running setup.py install for mozInstall 02:33:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:16 INFO - Running setup.py install for mozleak 02:33:16 INFO - Running setup.py install for mozlog 02:33:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for moznetwork 02:33:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for mozprocess 02:33:17 INFO - Running setup.py install for mozprofile 02:33:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for mozrunner 02:33:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Running setup.py install for mozscreenshot 02:33:17 INFO - Running setup.py install for moztest 02:33:17 INFO - Running setup.py install for mozversion 02:33:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:17 INFO - Cleaning up... 02:33:17 INFO - Return code: 0 02:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:17 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 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:17 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 02:33:17 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 02:33:17 INFO - Using env: {'DISPLAY': ':0', 02:33:17 INFO - 'HOME': '/home/cltbld', 02:33:17 INFO - 'LANG': 'en_US.UTF-8', 02:33:17 INFO - 'LANGUAGE': 'en_US:en', 02:33:17 INFO - 'LOGNAME': 'cltbld', 02:33:17 INFO - 'MAIL': '/var/mail/cltbld', 02:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:17 INFO - 'MOZ_NO_REMOTE': '1', 02:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:17 INFO - 'NO_EM_RESTART': '1', 02:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:17 INFO - 'PWD': '/builds/slave/test', 02:33:17 INFO - 'SHELL': '/bin/bash', 02:33:17 INFO - 'SHLVL': '1', 02:33:17 INFO - 'TERM': 'linux', 02:33:17 INFO - 'TMOUT': '86400', 02:33:17 INFO - 'USER': 'cltbld', 02:33:17 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:17 INFO - '_': '/tools/buildbot/bin/python'} 02:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:17 INFO - Running setup.py (path:/tmp/pip-elTRWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:18 INFO - Running setup.py (path:/tmp/pip-az_I1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:18 INFO - Running setup.py (path:/tmp/pip-IZbtj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:18 INFO - Running setup.py (path:/tmp/pip-AoFw3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:18 INFO - Running setup.py (path:/tmp/pip-b3Us0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:18 INFO - Running setup.py (path:/tmp/pip-mCzz8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:18 INFO - Running setup.py (path:/tmp/pip-0myudf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:18 INFO - Running setup.py (path:/tmp/pip-pfucro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:18 INFO - Running setup.py (path:/tmp/pip-0hRGsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:18 INFO - Running setup.py (path:/tmp/pip-B4XUyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:18 INFO - Running setup.py (path:/tmp/pip-kP8wyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:18 INFO - Running setup.py (path:/tmp/pip-Pd7wiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:18 INFO - Running setup.py (path:/tmp/pip-_RMhLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:18 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)) 02:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:18 INFO - Running setup.py (path:/tmp/pip-YzEBau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:19 INFO - Running setup.py (path:/tmp/pip-c3CYhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:19 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)) 02:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:19 INFO - Running setup.py (path:/tmp/pip-RBkCuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:19 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)) 02:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:19 INFO - Running setup.py (path:/tmp/pip-8Wkf5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:19 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)) 02:33:19 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)) 02:33:19 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)) 02:33:19 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)) 02:33:19 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)) 02:33:19 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)) 02:33:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:21 INFO - Downloading blessings-1.6.tar.gz 02:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:21 INFO - Installing collected packages: blessings 02:33:21 INFO - Running setup.py install for blessings 02:33:21 INFO - Successfully installed blessings 02:33:21 INFO - Cleaning up... 02:33:21 INFO - Return code: 0 02:33:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:21 INFO - Reading from file tmpfile_stdout 02:33:21 INFO - Current package versions: 02:33:21 INFO - argparse == 1.2.1 02:33:21 INFO - blessings == 1.6 02:33:21 INFO - blobuploader == 1.2.4 02:33:21 INFO - docopt == 0.6.1 02:33:21 INFO - functools32 == 3.2.3-2 02:33:21 INFO - jsonschema == 2.5.1 02:33:21 INFO - manifestparser == 1.1 02:33:21 INFO - mozInstall == 1.12 02:33:21 INFO - mozcrash == 0.17 02:33:21 INFO - mozdebug == 0.1 02:33:21 INFO - mozdevice == 0.48 02:33:21 INFO - mozfile == 1.2 02:33:21 INFO - mozhttpd == 0.7 02:33:21 INFO - mozinfo == 0.9 02:33:21 INFO - mozleak == 0.1 02:33:21 INFO - mozlog == 3.4 02:33:21 INFO - moznetwork == 0.27 02:33:21 INFO - mozprocess == 0.23 02:33:21 INFO - mozprofile == 0.28 02:33:21 INFO - mozrunner == 6.12 02:33:21 INFO - mozscreenshot == 0.1 02:33:21 INFO - mozsystemmonitor == 0.3 02:33:21 INFO - moztest == 0.7 02:33:21 INFO - mozversion == 1.4 02:33:21 INFO - psutil == 3.1.1 02:33:21 INFO - requests == 1.2.3 02:33:21 INFO - wsgiref == 0.1.2 02:33:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 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 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:21 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 02:33:21 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 02:33:21 INFO - Using env: {'DISPLAY': ':0', 02:33:21 INFO - 'HOME': '/home/cltbld', 02:33:21 INFO - 'LANG': 'en_US.UTF-8', 02:33:21 INFO - 'LANGUAGE': 'en_US:en', 02:33:21 INFO - 'LOGNAME': 'cltbld', 02:33:21 INFO - 'MAIL': '/var/mail/cltbld', 02:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:21 INFO - 'MOZ_NO_REMOTE': '1', 02:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:21 INFO - 'NO_EM_RESTART': '1', 02:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:21 INFO - 'PWD': '/builds/slave/test', 02:33:21 INFO - 'SHELL': '/bin/bash', 02:33:21 INFO - 'SHLVL': '1', 02:33:21 INFO - 'TERM': 'linux', 02:33:21 INFO - 'TMOUT': '86400', 02:33:21 INFO - 'USER': 'cltbld', 02:33:21 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:21 INFO - '_': '/tools/buildbot/bin/python'} 02:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 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)) 02:33:21 INFO - Cleaning up... 02:33:21 INFO - Return code: 0 02:33:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:21 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 0x7f3aa2e9ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x185fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', '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 02:33:21 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 02:33:21 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 02:33:21 INFO - Using env: {'DISPLAY': ':0', 02:33:21 INFO - 'HOME': '/home/cltbld', 02:33:21 INFO - 'LANG': 'en_US.UTF-8', 02:33:21 INFO - 'LANGUAGE': 'en_US:en', 02:33:21 INFO - 'LOGNAME': 'cltbld', 02:33:21 INFO - 'MAIL': '/var/mail/cltbld', 02:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:21 INFO - 'MOZ_NO_REMOTE': '1', 02:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:21 INFO - 'NO_EM_RESTART': '1', 02:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:21 INFO - 'PWD': '/builds/slave/test', 02:33:21 INFO - 'SHELL': '/bin/bash', 02:33:21 INFO - 'SHLVL': '1', 02:33:21 INFO - 'TERM': 'linux', 02:33:21 INFO - 'TMOUT': '86400', 02:33:21 INFO - 'USER': 'cltbld', 02:33:21 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:21 INFO - '_': '/tools/buildbot/bin/python'} 02:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:22 INFO - Cleaning up... 02:33:22 INFO - Return code: 0 02:33:22 INFO - Running post-action listener: _resource_record_post_action 02:33:22 INFO - Running post-action listener: _start_resource_monitoring 02:33:22 INFO - Starting resource monitoring. 02:33:22 INFO - [mozharness: 2016-10-04 09:33:22.114674Z] Finished create-virtualenv step (success) 02:33:22 INFO - [mozharness: 2016-10-04 09:33:22.115293Z] Running install step. 02:33:22 INFO - Running pre-action listener: _resource_record_pre_action 02:33:22 INFO - Running main action method: install 02:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:22 INFO - Reading from file tmpfile_stdout 02:33:22 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:22 INFO - Reading from file tmpfile_stdout 02:33:22 INFO - Output received: 02:33:22 INFO - Usage: mozinstall [options] installer 02:33:22 INFO - Options: 02:33:22 INFO - -h, --help show this help message and exit 02:33:22 INFO - -d DEST, --destination=DEST 02:33:22 INFO - Directory to install application into. [default: 02:33:22 INFO - "/builds/slave/test"] 02:33:22 INFO - --app=APP Application being installed. [default: firefox] 02:33:22 INFO - mkdir: /builds/slave/test/build/application 02:33:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:33:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:33:38 INFO - Reading from file tmpfile_stdout 02:33:38 INFO - Output received: 02:33:38 INFO - /builds/slave/test/build/application/firefox/firefox 02:33:38 INFO - Running post-action listener: _resource_record_post_action 02:33:38 INFO - [mozharness: 2016-10-04 09:33:38.532352Z] Finished install step (success) 02:33:38 INFO - [mozharness: 2016-10-04 09:33:38.532686Z] Running run-tests step. 02:33:38 INFO - Running pre-action listener: _resource_record_pre_action 02:33:38 INFO - Running main action method: run_tests 02:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:38 INFO - Python 2.7.3 02:33:38 INFO - Return code: 0 02:33:38 INFO - grabbing minidump binary from tooltool 02:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185cf60>, '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 0x185dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x185e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:38 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 02:33:38 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 02:33:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:33:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:38 INFO - Return code: 0 02:33:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:33:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:33:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:33:38 INFO - Using env: {'DISPLAY': ':0', 02:33:38 INFO - 'HOME': '/home/cltbld', 02:33:38 INFO - 'LANG': 'en_US.UTF-8', 02:33:38 INFO - 'LANGUAGE': 'en_US:en', 02:33:38 INFO - 'LOGNAME': 'cltbld', 02:33:38 INFO - 'MAIL': '/var/mail/cltbld', 02:33:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:38 INFO - 'MOZ_NO_REMOTE': '1', 02:33:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:38 INFO - 'NO_EM_RESTART': '1', 02:33:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:38 INFO - 'PWD': '/builds/slave/test', 02:33:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:38 INFO - 'SHELL': '/bin/bash', 02:33:38 INFO - 'SHLVL': '1', 02:33:38 INFO - 'TERM': 'linux', 02:33:38 INFO - 'TMOUT': '86400', 02:33:38 INFO - 'USER': 'cltbld', 02:33:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152', 02:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:38 INFO - '_': '/tools/buildbot/bin/python'} 02:33:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:33:38 INFO - mozversion application_buildid: 20161004010500 02:33:38 INFO - mozversion application_changeset: 4a938cf41515d9d1a952a6e454b6ac6d9a6c6877 02:33:38 INFO - mozversion application_display_name: Nightly 02:33:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:38 INFO - mozversion application_name: Firefox 02:33:38 INFO - mozversion application_remotingname: firefox 02:33:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 02:33:38 INFO - mozversion application_vendor: Mozilla 02:33:38 INFO - mozversion application_version: 52.0a1 02:33:38 INFO - mozversion platform_buildid: 20161004010500 02:33:38 INFO - mozversion platform_changeset: 4a938cf41515d9d1a952a6e454b6ac6d9a6c6877 02:33:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 02:33:38 INFO - mozversion platform_version: 52.0a1 02:33:38 INFO - using testdate: 1475573618 02:33:38 INFO - actual date: 1475573618 02:33:38 INFO - starting webserver on 'localhost:46477' 02:33:38 INFO - SUITE-START | Running 2 tests 02:33:38 INFO - TEST-START | dromaeo_css 02:33:38 INFO - operating with platform_type : linux_ 02:33:38 INFO - Initialising browser for dromaeo_css test... 02:33:38 INFO - TEST-INFO | started process 29133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy3R1hq/profile http://localhost:46477/getInfo.html) 02:33:43 INFO - PROCESS | 29133 | __metrics Screen width/height:1600/1200 02:33:43 INFO - PROCESS | 29133 | colorDepth:24 02:33:43 INFO - PROCESS | 29133 | Browser inner width/height: 1024/697 02:33:43 INFO - PROCESS | 29133 | __metrics 02:33:43 INFO - PROCESS | 29133 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:33:43 INFO - PROCESS | 29133 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:44 INFO - PROCESS | 29133 | console.error: PushService: 02:33:44 INFO - PROCESS | 29133 | stateChangeProcessEnqueue: Error transitioning state 02:33:44 INFO - PROCESS | 29133 | UnknownError 02:33:45 INFO - TEST-INFO | 29133: exit 0 02:33:45 INFO - Browser initialized. 02:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:33:45 INFO - TEST-INFO | started process 29219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy3R1hq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:57 INFO - PROCESS | 29219 | RSS: Main: 174710784 02:33:57 INFO - PROCESS | 29219 | 02:34:48 INFO - PROCESS | 29219 | 1475573688782 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] 02:37:01 INFO - PROCESS | 29219 | Cycle 1(1): loaded http://localhost:46477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46477/tests/dromaeo/cssquery-ext.html) 02:37:03 INFO - PROCESS | 29219 | RSS: Main: 343859200 02:37:03 INFO - PROCESS | 29219 | 02:40:06 INFO - PROCESS | 29219 | Cycle 1(1): loaded http://localhost:46477/tests/dromaeo/cssquery-ext.html (next: http://localhost:46477/tests/dromaeo/cssquery-jquery.html) 02:40:06 INFO - PROCESS | 29219 | RSS: Main: 276283392 02:40:06 INFO - PROCESS | 29219 | 02:43:09 INFO - PROCESS | 29219 | Cycle 1(1): loaded http://localhost:46477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46477/tests/dromaeo/cssquery-mootools.html) 02:43:09 INFO - PROCESS | 29219 | RSS: Main: 222158848 02:43:09 INFO - PROCESS | 29219 | 02:46:11 INFO - PROCESS | 29219 | Cycle 1(1): loaded http://localhost:46477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46477/tests/dromaeo/cssquery-prototype.html) 02:46:12 INFO - PROCESS | 29219 | RSS: Main: 219725824 02:46:12 INFO - PROCESS | 29219 | 02:49:15 INFO - PROCESS | 29219 | Cycle 1(1): loaded http://localhost:46477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46477/tests/dromaeo/cssquery-yui.html) 02:49:16 INFO - PROCESS | 29219 | RSS: Main: 219172864 02:49:16 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | Cycle 1(1): loaded http://localhost:46477/tests/dromaeo/cssquery-yui.html (next: http://localhost:46477/tests/dromaeo/cssquery-dojo.html) 02:52:19 INFO - PROCESS | 29219 | RSS: Main: 313094144 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | __start_tp_report 02:52:19 INFO - PROCESS | 29219 | _x_x_mozilla_page_load 02:52:19 INFO - PROCESS | 29219 | _x_x_mozilla_page_load_details 02:52:19 INFO - PROCESS | 29219 | |i|pagename|runs| 02:52:19 INFO - PROCESS | 29219 | |0;dojo.html;2590.5466543354914;2614.9477010459805;2647.96028059579;2663.7469440403165;2675.5317819381603;4525.027119169378;4597.195490789107;4696.856473870371;4805.111054454928;4840.225563909775;4616.19216637088;4626.074785042988;4628.1669299526075;4633.976830115845;4637.930431043537;4242.109157077018;4249.851255206068;4259.212045771526;4317.978410107945;4333.349997500384;4382.364557139213;4398.296272596369;4402.7578483183415;4405.845795397162;4422.204003279408;4329.047609525899;4430.689851710382;4432.800523976429;4437.156940181371;4490.865274041784;4379.737215767048;4447.043885564619;4447.933281000787;4472;4472.329150627399;4188.623023927861;4233.280342341809;4353.717008394476;4393.692441529094;4394.670399720002;4588.931166032512;4625.583697467244;4643.837465688718;4718.504557021498;4729.645276604234;4861.9027619447415;4862.902741945141;4873.926891096637;4942.258661200813;5009.874753131165;4915.729634870081;4936.4076310842565;4947.65366424354;4966.652334336598;5028.84913452597;4443.6889417741095;4485.529019452975;4588.403507543998;4640.930386044212;4726.976365118152;5074.82238121664;5085.1355269604255;5087.4149472811105;5092.694438333712;5131.512506311894;4836.46798852126;4887;4892.755362231946;4901.411830580353;4907.386576677915;4779.641526885497;4826.7827947742435;4867.050925069578;5000.524950129732;5000.649954503223;4956.925646115311;4958.45456999737;4959.504049595012;4975.0796102721115;5016.949830501721;4943.382077240345;4949.7772600233075;4957.603391728653;4959.7272150032095;5016.874578135576;4027.0536423940353;4075.694322925792;4076.8165432555606;4112.712110152321;4171.20747058058;3658.378075727133;3664.633536646314;3699.2416554606243;3723.106454450912;3729.720270979633;4368.847090351823;4370.366296886934;4376.627986621173;4377.277749171415;4426.247537918562;4869.220924652039;4927.531884470969;5037.496250375007;5046.77289521965;5104.336436263262;4344.543822898613;4385.101054283864;4439.822407103679;4443.733375997451;4481.7535035573355;4551.6813823032735;4570.063137056895;4570.177368073779;4571.2000399929875;4634.698744581591;4515.503294637521;4829.661923665451;4834.975825120852;4845.055214233191;4889.877753056202;4780.880477988078;4959.256111583291;5030.270610761492;5043.319151914591;5119.641625086358;4773;4776.283557466408;4780.139574876416;4781.450133234723;4823.421189457147;4682.063587282489;4970.229614409773;4970.353853998957;4978.178600530872;5034.194528875362;4787.4494433140635;4844.854654360375;4866.221404575251;4871.585915197248;4873.439554451284;4678.157931572349;4717.976410117927;4723.362346083235;4726.929096063493;4728.030753695553;4723.574878260973;4733.881652958704;4809.44691360484;4872.1717308057005;4894.779734911866;4837.661363704507;4842.7336496493035;4847.587955023862;4882.218844984785;4909.533594308535;4946.950530494649;4951.777170027285;4958.801647934042;4959.305697202322;4961.3798275215595;4612.354270402214;4663.160631086437;4666.370040044686;4719.961608446137;4857.222844344888 02:52:19 INFO - PROCESS | 29219 | |1;ext.html;537.7284471341973;554.2517601238332;563.8562166647504;564.7119968815903;569.1974316214137;28156.57765133522;38953.80523097384;40284;40288.59711402889;44145.7792711036;34621.653783462156;34832.303353932904;34883.47674784874;34891.30217395651;34905;7601.923980760191;7739;7742.8838567421535;7744.264294892005;7748.3413909817455;7600.619969001527;7676.961615191916;7683.961580192091;7685.730999415022;7688.231176882323;7684.615769211545;7726.961365193166;7739.729109481169;7740.729074482394;7755;7695.961520192392;7731.613419329011;7732.342750866183;7741.535507869546;7749.225077492262;7589.279018493235;7655.425843061737;7656.157822639505;7663.3486153677;7669.616519174075;38150.80924595387;38381.232375352614;38435;38485.230295393936;38507;2855.1006432973754;2902.2889392099073;2910;2929.414117176573;3032.1286140334423;27534.724652753415;27591.586126208123;27815.304617384525;28603.28491787722;28646.713532864615;3309.470484722457;3322.900312990614;3328.567286252796;3353.0946644406117;3374.780639258465;197792;254495;254547;254698;255060;53228.201576976375;53670.46329536733;53670.73164634152;53692;53706.06437809018;33078.66921330804;33881.32237355288;34085.48871766926;47324.29013564799;47559.76220118877;14010.369533371022;14134.787978180335;14160.07959482651;14206;14217.146971181763;10771.515281812337;10799.352038877692;10853.837192442119;10864.293820901774;10908.563657453613;17500.912495437442;17589.12054397275;17734.46796596104;17749;17811.376601818873;6523.804285871432;6757.425618822455;6803.353681400259;6852.314768523208;6870.519063665495;735.2941176470648;840.6805413942785;853.6798700487317;915.7619019055094;979.2900147393225;25911.611325829752;27477.713163808756;27667.58498622522;28120;28203.43593128126;719.6293908636951;831.4096991136361;846.7967687754895;909.8271328447706;969.6896992962326;11537.307761534335;11908.33283340333;13348.332583370986;13489.032412869154;13612.659683507793;363705;365156;365828;366621;366716;49165.75417122892;49708.502914970384;49787.75106124446;49809;49825.750871245415;1048.9423081730426;1089.9782004359868;1151.073385924339;1155.5146838327923;1166.585862018971;24988.37529061788;28747.856260718563;29023.854880725463;29184.41631167407;29187.270318242216;40267.39598906077;40866.38700419437;40880.1823963525;40893.182136357704;40920;283181;284018;284317;284625;284742;22555.43611409662;23370;23372.181973630843;24581.754182458662;24998.250052498453;40311.3953290695;40315.798421007705;40745.59254407418;41037.38443923284;41116.38325425181;30305.848470757504;30506;30529;30711.846440767655;31149.844250778602;34534.82732586321;35263.64736352603;35320.82339588286;35427.468587971714;35663.82168089143;34828.30343393169;35052.12369690778;35128.29743405169;35223.47164792479;36266;27222;27721.722782771914;27937;28574.142775716762;28774.568381473877;24415.51168976646;24763.752362476145;24795.752042479344;25201.74798251994;25241.747582523938 02:52:19 INFO - PROCESS | 29219 | |2;jquery.html;338.3132241549655;350.21377008615644;360.09077080372055;360.5403111033432;385.67795890431506;12005.459754311056;15402.152881591508;15888.841111588896;16306.429274975379;17069.48791536253;13715.451381944735;14147.151170929752;14217.360218790154;14979;16141.43504977326;3776.565694945089;4421.977890110553;4532.9093418131615;4583.724976501404;4598.229681572602;4909.484504127051;4994.97502512487;4996.1756310208775;4999.550040496355;4999.875003124915;4645.535446455361;4954.182559877634;4963.900721985558;4967.726775027372;4970.502949705019;4494.325851122341;4534.41052663155;4578.221702310615;4614.653900957442;4619.307103934403;4443.178012067778;4454.196050599512;4496.213162696515;4498;4499.820007199708;11291.774164516746;16316.673666526722;19765.703514447294;20252.493687657778;20372;1845.0313585367655;1851.3242666426656;1885.0480507343705;2080.063971212945;2240.9215677451375;8755.912440875574;9164;9495.430274183502;9585.233181345546;9839.163671087967;1694.0682624556446;1753.281154726556;1756.4379398592455;1766.3994241957796;1768.6639538487775;65280.3471965279;68025;69343.3065669347;71109.28890711078;72191.63904180499;9611.855822162674;9679.274054445945;9700.563474643657;9847.80304393908;9962.402255864672;13204.669883252996;13279.800802987962;13282.601521954357;13288.800667989988;13292.069555131047;5646.604737668324;5820.301563812285;5835.679037652885;6286.717097730613;7500.924990750132;6445.16212892321;6622;6675.098861653614;6730.663466826639;6873.450123990069;3798.772073675588;4101.384792281182;4166.104287578125;4249.46881639795;7254.724052230811;2843.8151520151123;2905.418916216765;3027.606411166534;3222.2610780836103;3286.5891763529557;771.6566128073066;856.6402111113347;882.6892065283049;907.9546022698971;961.2214106573698;16029.679406411806;16135.83864161367;16533.58666033359;17032.659346812994;17894.91052544729;825.5830805443213;835.6406745099665;835.7409203147043;852.7015544559355;853.5646820121783;8467.153284671607;9798.412095274163;9809.11717945374;9816.607335706492;9818.459984700767;341659;347816;351027;351080;364506;79645;80699.59650201711;80893.59553202314;82664;85707;871.8866547348931;895.4850960697624;898.3621628643737;898.7034278688018;907.1971305394641;15118.773218401513;15243.618909527351;15296.541103766906;15399.923000384926;16057.759133612772;36058.27883442264;36242.63757362393;36484;37185.07037324089;38508;49875.75062124666;51072.489275106775;51449.742751286;51492.74253628708;52261.648225829165;6861.627674465227;7230.42156627479;7269.672864720995;7324.267573242633;7527;9574.55268389662;11271.605493807678;12094.818577721517;12171.634850954486;12335.814962775386;10204.744881377728;10211.897881021392;10256.641017564349;10344.172466202535;10815.72960675958;10348.844767328346;10613.363198208132;10637.840432393676;10829.29609575375;10872.565097396331;9924;10409.84385234207;10662.46687665598;10836.620718274822;10862.511186996762;6987.406070484066;7060.505764596429;7103.2186459488385;7181.605011724405;7191.676374563052;9642.42145471274;10441.634542790965;10580.576776928836;10753.784924301313;10763.892361076289 02:52:19 INFO - PROCESS | 29219 | |3;mootools.html;1303.347687456027;1346.1855577375688;1395.8185435893338;1562.6777175014959;1613.9670610809085;6725.9327406725915;6954.269801670827;7346.55920644761;7948.761537153895;7950.562719050457;7300.744473943413;7614.200508946564;7615.162332143474;7784.532928024322;7804.843903121949;2124.798144176301;2128.095559387262;2137.5831712816007;2154.2244791874914;2162.5350549631826;1765.735139729038;1822.2073398071882;2090.2579584247524;2118.756343020549;2155.3426205007468;1730.8701847361435;1745.738139279112;1748.763916871225;2088.7702352741185;2106.1470104607583;2071.1818831561523;2073.699313599535;2081.40679906226;2087.5929193807137;2088.185607613017;2029.2694629933212;2039.2250944640941;2068.5759419319;2079.781622929586;2081.323569839808;7626;7716.074071111447;7716.382689384835;7779.72770953014;7819.726309579194;4282.42187304713;4404.185225733249;4405.603495685404;4407.140607581523;4415.4259946206785;2561.039610146195;2712.918221445561;2804.929876753077;2820.830750154997;2829.6462942132234;846.1496196322718;874.4010352908278;875.9969834539417;877.4296707140346;889.515214208258;10168.44073575953;10255;10263.127634151106;10266.640667576674;10269.589216431334;3793.7534060285993;3870.5161854768153;3987.8404863805704;4009.7594144351433;4090.795460226977;8808.955955220312;8810.251128654008;8821.294296456268;8825.602847871733;8826.117388261122;4437.090396468716;4438.245498265238;4440.444944381952;4442.644588432918;4445.644348452116;4004.3793212051596;4038.7172897897453;4060.5939406059747;4066.694997875112;4067.1052368478886;3418.7948723076697;3440.139965008748;3472.3749725049734;3506.9298614027575;3588.300281445145;1083.409541799721;1090.5583238788304;1093.3221402730358;1107.9169062320198;1111.8332250162541;691.2120182991393;802.594689681707;806.2099142839933;818.7789296889806;826.9297109745619;4853.635977301717;4882;4979.6265280104135;4990.525900039491;5170.8965820684125;377.16458045429505;390.4026838936432;395.4819186865158;399.31916083078283;400.14968192590743;3337.7997320160866;3431.9656803431644;3434.914127146841;3468.098294443412;3503.2292895562937;8577.571121444027;8814.911850881537;8908.420952638058;8923.73228803137;8934.821303573892;8876.112388761072;8893.28853691703;8896.59965301563;8913.55432228386;8918.37571369998;6573.967130164318;6664.1336626239245;6670.599764014175;6673.332666733288;6676.365745254193;4873.098476781806;4947.183714687037;5021.72380519075;5130.368745253607;5190.403103642979;8328.08391076969;8379.120192379713;8396.160383961555;8408.537530435884;8502.022267439324;8443.113473085237;8475.449095808754;8513.233808957224;8575.571221438779;8626.137386261324;6428.4214420702365;6538.705758240795;6551.574147680385;6588.4399826013405;6595.076689263411;7114.466415018997;7254.637268136466;7308.232635573401;7318.743843965649;7324.08448943882;5116.232565115262;6455.9677201613695;6524.5432819704065;6540.640264785482;6674.43267322283;6554.934450655433;6591.96704016496;6637.236717777518;6649.767258145942;6678.565893216925;5961.165436838759;6078.787242446493;6082.148499210202;6088.117223002729;6092.208012958287;4472.485664148535;4477.597016268552;4490.416245888014;4555.612772914339;4694.64790140734;4315.158544083999;4395.450568678915;4405.5153933066695;4537.455505339381;4564.817407303671 02:52:19 INFO - PROCESS | 29219 | |4;prototype.html;275.7986669731096;278.9414223013167;287.3319532087895;287.8643750404653;293.36632872994335;4792.928106078407;4809.38885473366;4825.445073816508;4834.371531700883;4841.903161936759;4734.479207287196;4752.47722750498;4776.641751868607;4785.832495862645;4792.233242681172;3565.94651080234;3617.656322649357;3674.926501469969;3706.7219958503083;3755.1738617504243;3736.9252614947686;3742.7754334739866;3744.6629803317696;3757.943630845526;3760.586335503106;3703.8518459261595;3708.962910370902;3716.145286584074;3716.293904158215;3722.646348596879;3512.947305790415;3613.8012409317475;3622.87319943802;3692.8153592320277;3721.4603882436895;3280.8359582020803;3283.40898638245;3287.1453422110185;3293.752968527346;3293.8682452701864;4620.768961551909;4626.542639068683;4626.629869610457;4628.310666606664;4631.606313463326;3941.467901833273;4193.559676233982;4234.597713217239;4234.767087810169;4244.236037513247;4965.48552691429;4968.378952630921;4968.726720030397;4974.825881094144;4988.102141614508;3500.9824950875336;3501.124718820295;3502.2470168913806;3508.1931155834045;3510.9642655416715;5004.799808007639;5172.715500647463;5211.462618527506;5225.555827754645;5228.686278823283;3538.363094642989;3540.8760693375607;3553.6673747344744;3569.3396721606587;3578.4453409721536;3606.1151079136584;3608.963910360915;3610.6389361063684;3620.2759448110482;3629.911026691982;4191.790410479463;4194.6853985951175;4197.9370309445385;4211.831526738957;4221.810018549173;4921.8523444296725;4978.27814966835;5000.524845170683;5091.236314552847;5093.923591146136;1245.6449911775283;1256.145820841818;1256.7989121740661;1257.289631358298;1266.468083404972;762.4357975098387;776.5961699916124;786.1666633368648;794.4875555266821;798.7883210949103;4289.528151903288;4338.349247612883;4469.642428605704;4473.373727678128;4482.574155455227;5160.509751573594;5165.431802501722;5166.844994650167;5184;5191.402988656353;4450;4483.125790470892;4483.820647174141;4491.371208030879;4499.572540608637;2599.9480010399684;2743.477370059596;2750.573661082535;2765.5298599238176;2765.9723402766117;4880.633952453509;4887.828925987645;4896.674079812061;4912.582430493377;4914.164592019365;5049.747512624354;5234.633575649744;5283.920741188886;5287.550558202596;5302.416734159239;4928.926066109011;4950.4059512858685;4962.255661650709;4971.776270067856;4975.676581022222;5237.947620523746;5254.500822421864;5265.2365407015;5318.755559109018;5319.574434045345;4858.684185527929;5078.873028174326;5159.355080614773;5168.276441298296;5192.792288308577;4918.827841025547;4928.950710492849;4943.431505376784;4952.529509696573;4960.652754307308;3516.2088530080528;3546.1737205338754;3552.87564935226;3578.8031658259047;3595.4786555948717;5082.771275292546;5198.142306519382;5240.34495688039;5263.36839579253;5290.81482148123;5049.444561098203;5061.114304996538;5065.746712664426;5071.855449621258;5100.336956195671;5060.873478163076;5067.87330316745;5075.923861142012;5145.195868251886;5148.794048238028;4759.666823322473;4990.775415106402;5011.273365362075;5022.397312322545;5049.166887463527;4847.316039809841;4950.331705219894;4979.182598351503;5120.641555091108;5124.205748109049;4906.313116163668;4914.238293064581;4936.456989731055;4941.703497790144;4944.134776414185 02:52:19 INFO - PROCESS | 29219 | |5;yui.html;593.7230720188079;641.4771960851903;654.4862283107761;662.8475450646348;716.0834132310641;12609.5586654467;13312.93343533281;13707.246101464416;13888;13894.51369202078;13343.199408035525;13673.24797136157;13695.931520342385;13702.725945481085;13709.177449353047;634.1755717567167;760.425878461762;783.3967844759532;787.2285160542672;787.8818177273398;640.5900223856736;767.267259766924;779.6842278877064;790.0795573157264;792.8136887831355;828.3787159630277;828.70580943765;828.846663367279;832.9541875196862;835.5822088955522;650.6193876582205;819.8237378963491;820.7332616899472;820.9507429554246;821.6959724901794;490.0639778023957;582.8571999860061;590.6751286792247;592.973316200772;595.8916415467228;12874.227546347156;12888.677783055406;12906.290154041524;12936.611901642966;13014.934925325313;10926.672199834018;11585.073194144448;11668.88331116695;11675.708107297301;12054.337011464366;10942.617008404668;10988.450577471094;11055.778884422347;11145.331280123137;11615.070794336518;3939.995301198176;3940.940885886714;3964.8697577688995;3967.504061992251;4006.4591280177387;62409;62669.68665156691;62873.371266287206;62914.37085629177;62968.37031629671;9270.034712683891;9320.627174913063;9357.859632105525;9405.584162152214;9430.597026048172;17074.743878841826;17159.227834747468;17331.826681733273;17404.912975435043;17440.12799360027;6296.905546416808;6381.585196962183;6392.680365981775;6547.312532184052;6714.496412769062;3410.437277849127;3457.135716070982;3515.7890526567976;3543.078799512094;3581.8925432237074;2687.6237326774267;2762.2956146182596;2773.5007698614445;2773.9029133980616;2775.9028434005118;463.2009783124084;471.1754429747941;471.32365056144545;477.06019142289637;477.28645674716523;520.3989392251955;561.5942927731936;567.51761003147;567.9943200568024;580.2543731305337;7890.487118337404;7954.403419743542;7963.4027447941635;7994.2405471480115;8099.311558517592;402.3140545370137;431.91577642359437;502.9739331763235;582.8805094955524;598.4583951523878;3674.3386190485435;3706.4440333949583;3884.766913985113;3959.1685745993086;3986.123052928351;84953;102860.37128329244;106200;108478;108758;88595;88779;89096;90882.54558727297;91081;73308.63345683238;78493.82259266115;79366.6031669838;80945;81096;7202.099737532809;7213.422926165999;7254.927450725636;7379.778606641809;7533.3973282138395;44791.32813007873;44953.55046449494;45193.32210016918;45305;47240.7637961808;61931;64887.35112648813;65986.34013659802;66683.66658166678;69126.65436672785;9210.585523651585;9255.120763527455;9384.483853388128;9657.951710241405;9710.320277580502;10136.543855526372;10179.134773544036;10481.580736770444;10549.156067514426;10561.471926403496;9479.336446448959;9678.734831907754;9979.251556133175;9986.550605222637;10036.849447258443;9813.460259685786;9828.361156524803;10187.643432479828;10450.581976720847;10498.422586757497;9565.473898935625;9708.660196893357;10062.345947513388;10066.094051535398;10076.798464030531;7729.497582657109;7857.685692572233;7920.960395198218;8008.479448835807;8345.290650294794;8013.2387423194705;8248.628811703367;8367.790805229917;8409.579521023801;8542.572871356531 02:52:19 INFO - PROCESS | 29219 | __end_tp_report 02:52:19 INFO - PROCESS | 29219 | __start_cc_report 02:52:19 INFO - PROCESS | 29219 | _x_x_mozilla_cycle_collect,1651 02:52:19 INFO - PROCESS | 29219 | __end_cc_report 02:52:19 INFO - PROCESS | 29219 | __startTimestamp1475574739506__endTimestamp 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | ------- Summary: start ------- 02:52:19 INFO - PROCESS | 29219 | Number of tests: 6 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | [#0] dojo.html Cycles:165 Average:4614.81 Median:4726.98 stddev:466.55 (9.9%) stddev-sans-first:440.13 02:52:19 INFO - PROCESS | 29219 | Values: 2590.5 2614.9 2648.0 2663.7 2675.5 4525.0 4597.2 4696.9 4805.1 4840.2 4616.2 4626.1 4628.2 4634.0 4637.9 4242.1 4249.9 4259.2 4318.0 4333.3 4382.4 4398.3 4402.8 4405.8 4422.2 4329.0 4430.7 4432.8 4437.2 4490.9 4379.7 4447.0 4447.9 4472.0 4472.3 4188.6 4233.3 4353.7 4393.7 4394.7 4588.9 4625.6 4643.8 4718.5 4729.6 4861.9 4862.9 4873.9 4942.3 5009.9 4915.7 4936.4 4947.7 4966.7 5028.8 4443.7 4485.5 4588.4 4640.9 4727.0 5074.8 5085.1 5087.4 5092.7 5131.5 4836.5 4887.0 4892.8 4901.4 4907.4 4779.6 4826.8 4867.1 5000.5 5000.6 4956.9 4958.5 4959.5 4975.1 5016.9 4943.4 4949.8 4957.6 4959.7 5016.9 4027.1 4075.7 4076.8 4112.7 4171.2 3658.4 3664.6 3699.2 3723.1 3729.7 4368.8 4370.4 4376.6 4377.3 4426.2 4869.2 4927.5 5037.5 5046.8 5104.3 4344.5 4385.1 4439.8 4443.7 4481.8 4551.7 4570.1 4570.2 4571.2 4634.7 4515.5 4829.7 4835.0 4845.1 4889.9 4780.9 4959.3 5030.3 5043.3 5119.6 4773.0 4776.3 4780.1 4781.5 4823.4 4682.1 4970.2 4970.4 4978.2 5034.2 4787.4 4844.9 4866.2 4871.6 4873.4 4678.2 4718.0 4723.4 4726.9 4728.0 4723.6 4733.9 4809.4 4872.2 4894.8 4837.7 4842.7 4847.6 4882.2 4909.5 4947.0 4951.8 4958.8 4959.3 4961.4 4612.4 4663.2 4666.4 4720.0 4857.2 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | [#1] ext.html Cycles:180 Average:44460.50 Median:34978.56 stddev:79508.07 (227.3%) stddev-sans-first:79662.71 02:52:19 INFO - PROCESS | 29219 | Values: 537.7 554.3 563.9 564.7 569.2 28156.6 38953.8 40284.0 40288.6 44145.8 34621.7 34832.3 34883.5 34891.3 34905.0 7601.9 7739.0 7742.9 7744.3 7748.3 7600.6 7677.0 7684.0 7685.7 7688.2 7684.6 7727.0 7739.7 7740.7 7755.0 7696.0 7731.6 7732.3 7741.5 7749.2 7589.3 7655.4 7656.2 7663.3 7669.6 38150.8 38381.2 38435.0 38485.2 38507.0 2855.1 2902.3 2910.0 2929.4 3032.1 27534.7 27591.6 27815.3 28603.3 28646.7 3309.5 3322.9 3328.6 3353.1 3374.8 197792.0 254495.0 254547.0 254698.0 255060.0 53228.2 53670.5 53670.7 53692.0 53706.1 33078.7 33881.3 34085.5 47324.3 47559.8 14010.4 14134.8 14160.1 14206.0 14217.1 10771.5 10799.4 10853.8 10864.3 10908.6 17500.9 17589.1 17734.5 17749.0 17811.4 6523.8 6757.4 6803.4 6852.3 6870.5 735.3 840.7 853.7 915.8 979.3 25911.6 27477.7 27667.6 28120.0 28203.4 719.6 831.4 846.8 909.8 969.7 11537.3 11908.3 13348.3 13489.0 13612.7 363705.0 365156.0 365828.0 366621.0 366716.0 49165.8 49708.5 49787.8 49809.0 49825.8 1048.9 1090.0 1151.1 1155.5 1166.6 24988.4 28747.9 29023.9 29184.4 29187.3 40267.4 40866.4 40880.2 40893.2 40920.0 283181.0 284018.0 284317.0 284625.0 284742.0 22555.4 23370.0 23372.2 24581.8 24998.3 40311.4 40315.8 40745.6 41037.4 41116.4 30305.8 30506.0 30529.0 30711.8 31149.8 34534.8 35263.6 35320.8 35427.5 35663.8 34828.3 35052.1 35128.3 35223.5 36266.0 27222.0 27721.7 27937.0 28574.1 28774.6 24415.5 24763.8 24795.8 25201.7 25241.7 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | [#2] jquery.html Cycles:180 Average:23072.90 Median:4495.27 stddev:58471.63 (1300.7%) stddev-sans-first:58610.74 02:52:19 INFO - PROCESS | 29219 | Values: 338.3 350.2 360.1 360.5 385.7 12005.5 15402.2 15888.8 16306.4 17069.5 13715.5 14147.2 14217.4 14979.0 16141.4 3776.6 4422.0 4532.9 4583.7 4598.2 4909.5 4995.0 4996.2 4999.6 4999.9 4645.5 4954.2 4963.9 4967.7 4970.5 4494.3 4534.4 4578.2 4614.7 4619.3 4443.2 4454.2 4496.2 4498.0 4499.8 11291.8 16316.7 19765.7 20252.5 20372.0 1845.0 1851.3 1885.0 2080.1 2240.9 8755.9 9164.0 9495.4 9585.2 9839.2 1694.1 1753.3 1756.4 1766.4 1768.7 65280.3 68025.0 69343.3 71109.3 72191.6 9611.9 9679.3 9700.6 9847.8 9962.4 13204.7 13279.8 13282.6 13288.8 13292.1 5646.6 5820.3 5835.7 6286.7 7500.9 6445.2 6622.0 6675.1 6730.7 6873.5 3798.8 4101.4 4166.1 4249.5 7254.7 2843.8 2905.4 3027.6 3222.3 3286.6 771.7 856.6 882.7 908.0 961.2 16029.7 16135.8 16533.6 17032.7 17894.9 825.6 835.6 835.7 852.7 853.6 8467.2 9798.4 9809.1 9816.6 9818.5 341659.0 347816.0 351027.0 351080.0 364506.0 79645.0 80699.6 80893.6 82664.0 85707.0 871.9 895.5 898.4 898.7 907.2 15118.8 15243.6 15296.5 15399.9 16057.8 36058.3 36242.6 36484.0 37185.1 38508.0 49875.8 51072.5 51449.7 51492.7 52261.6 6861.6 7230.4 7269.7 7324.3 7527.0 9574.6 11271.6 12094.8 12171.6 12335.8 10204.7 10211.9 10256.6 10344.2 10815.7 10348.8 10613.4 10637.8 10829.3 10872.6 9924.0 10409.8 10662.5 10836.6 10862.5 6987.4 7060.5 7103.2 7181.6 7191.7 9642.4 10441.6 10580.6 10753.8 10763.9 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | [#3] mootools.html Cycles:180 Average:4891.56 Median:4863.37 stddev:2761.57 (56.8%) stddev-sans-first:2756.16 02:52:19 INFO - PROCESS | 29219 | Values: 1303.3 1346.2 1395.8 1562.7 1614.0 6725.9 6954.3 7346.6 7948.8 7950.6 7300.7 7614.2 7615.2 7784.5 7804.8 2124.8 2128.1 2137.6 2154.2 2162.5 1765.7 1822.2 2090.3 2118.8 2155.3 1730.9 1745.7 1748.8 2088.8 2106.1 2071.2 2073.7 2081.4 2087.6 2088.2 2029.3 2039.2 2068.6 2079.8 2081.3 7626.0 7716.1 7716.4 7779.7 7819.7 4282.4 4404.2 4405.6 4407.1 4415.4 2561.0 2712.9 2804.9 2820.8 2829.6 846.1 874.4 876.0 877.4 889.5 10168.4 10255.0 10263.1 10266.6 10269.6 3793.8 3870.5 3987.8 4009.8 4090.8 8809.0 8810.3 8821.3 8825.6 8826.1 4437.1 4438.2 4440.4 4442.6 4445.6 4004.4 4038.7 4060.6 4066.7 4067.1 3418.8 3440.1 3472.4 3506.9 3588.3 1083.4 1090.6 1093.3 1107.9 1111.8 691.2 802.6 806.2 818.8 826.9 4853.6 4882.0 4979.6 4990.5 5170.9 377.2 390.4 395.5 399.3 400.1 3337.8 3432.0 3434.9 3468.1 3503.2 8577.6 8814.9 8908.4 8923.7 8934.8 8876.1 8893.3 8896.6 8913.6 8918.4 6574.0 6664.1 6670.6 6673.3 6676.4 4873.1 4947.2 5021.7 5130.4 5190.4 8328.1 8379.1 8396.2 8408.5 8502.0 8443.1 8475.4 8513.2 8575.6 8626.1 6428.4 6538.7 6551.6 6588.4 6595.1 7114.5 7254.6 7308.2 7318.7 7324.1 5116.2 6456.0 6524.5 6540.6 6674.4 6554.9 6592.0 6637.2 6649.8 6678.6 5961.2 6078.8 6082.1 6088.1 6092.2 4472.5 4477.6 4490.4 4555.6 4694.6 4315.2 4395.5 4405.5 4537.5 4564.8 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | [#4] prototype.html Cycles:180 Average:4161.90 Median:4792.58 stddev:1234.84 (25.8%) stddev-sans-first:1203.36 02:52:19 INFO - PROCESS | 29219 | Values: 275.8 278.9 287.3 287.9 293.4 4792.9 4809.4 4825.4 4834.4 4841.9 4734.5 4752.5 4776.6 4785.8 4792.2 3565.9 3617.7 3674.9 3706.7 3755.2 3736.9 3742.8 3744.7 3757.9 3760.6 3703.9 3709.0 3716.1 3716.3 3722.6 3512.9 3613.8 3622.9 3692.8 3721.5 3280.8 3283.4 3287.1 3293.8 3293.9 4620.8 4626.5 4626.6 4628.3 4631.6 3941.5 4193.6 4234.6 4234.8 4244.2 4965.5 4968.4 4968.7 4974.8 4988.1 3501.0 3501.1 3502.2 3508.2 3511.0 5004.8 5172.7 5211.5 5225.6 5228.7 3538.4 3540.9 3553.7 3569.3 3578.4 3606.1 3609.0 3610.6 3620.3 3629.9 4191.8 4194.7 4197.9 4211.8 4221.8 4921.9 4978.3 5000.5 5091.2 5093.9 1245.6 1256.1 1256.8 1257.3 1266.5 762.4 776.6 786.2 794.5 798.8 4289.5 4338.3 4469.6 4473.4 4482.6 5160.5 5165.4 5166.8 5184.0 5191.4 4450.0 4483.1 4483.8 4491.4 4499.6 2599.9 2743.5 2750.6 2765.5 2766.0 4880.6 4887.8 4896.7 4912.6 4914.2 5049.7 5234.6 5283.9 5287.6 5302.4 4928.9 4950.4 4962.3 4971.8 4975.7 5237.9 5254.5 5265.2 5318.8 5319.6 4858.7 5078.9 5159.4 5168.3 5192.8 4918.8 4929.0 4943.4 4952.5 4960.7 3516.2 3546.2 3552.9 3578.8 3595.5 5082.8 5198.1 5240.3 5263.4 5290.8 5049.4 5061.1 5065.7 5071.9 5100.3 5060.9 5067.9 5075.9 5145.2 5148.8 4759.7 4990.8 5011.3 5022.4 5049.2 4847.3 4950.3 4979.2 5120.6 5124.2 4906.3 4914.2 4936.5 4941.7 4944.1 02:52:19 INFO - PROCESS | 29219 | 02:52:19 INFO - PROCESS | 29219 | [#5] yui.html Cycles:180 Average:17824.26 Median:597.18 stddev:26788.40 (4485.9%) stddev-sans-first:26832.31 02:52:19 INFO - PROCESS | 29219 | Values: 593.7 641.5 654.5 662.8 716.1 12609.6 13312.9 13707.2 13888.0 13894.5 13343.2 13673.2 13695.9 13702.7 13709.2 634.2 760.4 783.4 787.2 787.9 640.6 767.3 779.7 790.1 792.8 828.4 828.7 828.8 833.0 835.6 650.6 819.8 820.7 821.0 821.7 490.1 582.9 590.7 593.0 595.9 12874.2 12888.7 12906.3 12936.6 13014.9 10926.7 11585.1 11668.9 11675.7 12054.3 10942.6 10988.5 11055.8 11145.3 11615.1 3940.0 3940.9 3964.9 3967.5 4006.5 62409.0 62669.7 62873.4 62914.4 62968.4 9270.0 9320.6 9357.9 9405.6 9430.6 17074.7 17159.2 17331.8 17404.9 17440.1 6296.9 6381.6 6392.7 6547.3 6714.5 3410.4 3457.1 3515.8 3543.1 3581.9 2687.6 2762.3 2773.5 2773.9 2775.9 463.2 471.2 471.3 477.1 477.3 520.4 561.6 567.5 568.0 580.3 7890.5 7954.4 7963.4 7994.2 8099.3 402.3 431.9 503.0 582.9 598.5 3674.3 3706.4 3884.8 3959.2 3986.1 84953.0 102860.4 106200.0 108478.0 108758.0 88595.0 88779.0 89096.0 90882.5 91081.0 73308.6 78493.8 79366.6 80945.0 81096.0 7202.1 7213.4 7254.9 7379.8 7533.4 44791.3 44953.6 45193.3 45305.0 47240.8 61931.0 64887.4 65986.3 66683.7 69126.7 9210.6 9255.1 9384.5 9658.0 9710.3 10136.5 10179.1 10481.6 10549.2 10561.5 9479.3 9678.7 9979.3 9986.6 10036.8 9813.5 9828.4 10187.6 10450.6 10498.4 9565.5 9708.7 10062.3 10066.1 10076.8 7729.5 7857.7 7921.0 8008.5 8345.3 8013.2 8248.6 8367.8 8409.6 8542.6 02:52:19 INFO - PROCESS | 29219 | -------- Summary: end -------- 02:52:19 INFO - PROCESS | 29219 | 02:52:20 INFO - TEST-INFO | 29219: exit 0 02:52:20 INFO - TEST-OK | dromaeo_css | took 1121711ms 02:52:20 INFO - TEST-START | kraken 02:52:20 INFO - operating with platform_type : linux_ 02:52:20 INFO - Initialising browser for kraken test... 02:52:20 INFO - TEST-INFO | started process 29525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJT0eD_/profile http://localhost:46477/getInfo.html) 02:52:25 INFO - PROCESS | 29525 | __metrics Screen width/height:1600/1200 02:52:25 INFO - PROCESS | 29525 | colorDepth:24 02:52:25 INFO - PROCESS | 29525 | Browser inner width/height: 1024/697 02:52:25 INFO - PROCESS | 29525 | __metrics 02:52:25 INFO - PROCESS | 29525 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:52:25 INFO - PROCESS | 29525 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:52:26 INFO - PROCESS | 29525 | console.error: PushService: 02:52:26 INFO - PROCESS | 29525 | stateChangeProcessEnqueue: Error transitioning state 02:52:26 INFO - PROCESS | 29525 | UnknownError 02:52:26 INFO - TEST-INFO | 29525: exit 0 02:52:26 INFO - Browser initialized. 02:52:26 INFO - Running cycle 1/1 for kraken test... 02:52:26 INFO - TEST-INFO | started process 29606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJT0eD_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:39 INFO - PROCESS | 29606 | RSS: Main: 174862336 02:52:39 INFO - PROCESS | 29606 | 02:52:41 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46477/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:42 INFO - PROCESS | 29606 | RSS: Main: 233226240 02:52:42 INFO - PROCESS | 29606 | 02:52:45 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46477/tests/kraken/driver.html?testName=audio-dft) 02:52:46 INFO - PROCESS | 29606 | RSS: Main: 218669056 02:52:46 INFO - PROCESS | 29606 | 02:52:49 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46477/tests/kraken/driver.html?testName=audio-fft) 02:52:50 INFO - PROCESS | 29606 | RSS: Main: 300802048 02:52:50 INFO - PROCESS | 29606 | 02:52:52 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46477/tests/kraken/driver.html?testName=audio-oscillator) 02:52:52 INFO - PROCESS | 29606 | RSS: Main: 208539648 02:52:52 INFO - PROCESS | 29606 | 02:52:55 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:55 INFO - PROCESS | 29606 | RSS: Main: 213975040 02:52:55 INFO - PROCESS | 29606 | 02:52:58 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46477/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:59 INFO - PROCESS | 29606 | RSS: Main: 250249216 02:52:59 INFO - PROCESS | 29606 | 02:53:02 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46477/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:03 INFO - PROCESS | 29606 | RSS: Main: 245231616 02:53:03 INFO - PROCESS | 29606 | 02:53:06 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46477/tests/kraken/driver.html?testName=json-parse-financial) 02:53:07 INFO - PROCESS | 29606 | RSS: Main: 247156736 02:53:07 INFO - PROCESS | 29606 | 02:53:08 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:09 INFO - PROCESS | 29606 | RSS: Main: 211070976 02:53:09 INFO - PROCESS | 29606 | 02:53:11 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:11 INFO - PROCESS | 29606 | RSS: Main: 217124864 02:53:11 INFO - PROCESS | 29606 | 02:53:14 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:14 INFO - PROCESS | 29606 | RSS: Main: 227028992 02:53:14 INFO - PROCESS | 29606 | 02:53:17 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:18 INFO - PROCESS | 29606 | RSS: Main: 236388352 02:53:18 INFO - PROCESS | 29606 | 02:53:21 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:21 INFO - PROCESS | 29606 | RSS: Main: 232808448 02:53:21 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | Cycle 1(1): loaded http://localhost:46477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46477/tests/kraken/driver.html?testName=ai-astar) 02:53:23 INFO - PROCESS | 29606 | RSS: Main: 283410432 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | __start_tp_report 02:53:23 INFO - PROCESS | 29606 | _x_x_mozilla_page_load 02:53:23 INFO - PROCESS | 29606 | _x_x_mozilla_page_load_details 02:53:23 INFO - PROCESS | 29606 | |i|pagename|runs| 02:53:23 INFO - PROCESS | 29606 | |0;ai-astar;114;114;116;115;113;115;114;113;114;114 02:53:23 INFO - PROCESS | 29606 | |1;audio-beat-detection;153;125;127;171;138;128;128;129;178;132 02:53:23 INFO - PROCESS | 29606 | |2;audio-dft;162;161;161;161;162;160;161;161;161;161 02:53:23 INFO - PROCESS | 29606 | |3;audio-fft;75;75;77;114;77;77;77;77;97;75 02:53:23 INFO - PROCESS | 29606 | |4;audio-oscillator;85;83;117;84;83;83;103;82;83;110 02:53:23 INFO - PROCESS | 29606 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 02:53:23 INFO - PROCESS | 29606 | |6;imaging-darkroom;145;146;147;146;147;147;147;149;148;145 02:53:23 INFO - PROCESS | 29606 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;94;95 02:53:23 INFO - PROCESS | 29606 | |8;json-parse-financial;64;62;63;64;65;65;67;64;70;64 02:53:23 INFO - PROCESS | 29606 | |9;json-stringify-tinderbox;65;65;66;65;66;67;65;66;65;65 02:53:23 INFO - PROCESS | 29606 | |10;stanford-crypto-aes;93;87;90;83;83;83;91;83;83;83 02:53:23 INFO - PROCESS | 29606 | |11;stanford-crypto-ccm;151;138;148;148;140;138;138;140;176;139 02:53:23 INFO - PROCESS | 29606 | |12;stanford-crypto-pbkdf2;180;182;174;176;175;175;174;175;176;173 02:53:23 INFO - PROCESS | 29606 | |13;stanford-crypto-sha256-iterative;71;72;73;74;70;70;74;70;70;72 02:53:23 INFO - PROCESS | 29606 | __end_tp_report 02:53:23 INFO - PROCESS | 29606 | __start_cc_report 02:53:23 INFO - PROCESS | 29606 | _x_x_mozilla_cycle_collect,1934 02:53:23 INFO - PROCESS | 29606 | __end_cc_report 02:53:23 INFO - PROCESS | 29606 | __startTimestamp1475574803954__endTimestamp 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | ------- Summary: start ------- 02:53:23 INFO - PROCESS | 29606 | Number of tests: 14 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 02:53:23 INFO - PROCESS | 29606 | Values: 114.0 114.0 116.0 115.0 113.0 115.0 114.0 113.0 114.0 114.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:135.00 stddev:19.54 (14.5%) stddev-sans-first:20.23 02:53:23 INFO - PROCESS | 29606 | Values: 153.0 125.0 127.0 171.0 138.0 128.0 128.0 129.0 178.0 132.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 02:53:23 INFO - PROCESS | 29606 | Values: 162.0 161.0 161.0 161.0 162.0 160.0 161.0 161.0 161.0 161.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:13.00 (16.9%) stddev-sans-first:13.53 02:53:23 INFO - PROCESS | 29606 | Values: 75.0 75.0 77.0 114.0 77.0 77.0 77.0 77.0 97.0 75.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:83.00 stddev:13.34 (16.1%) stddev-sans-first:13.96 02:53:23 INFO - PROCESS | 29606 | Values: 85.0 83.0 117.0 84.0 83.0 83.0 103.0 82.0 83.0 110.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:53:23 INFO - PROCESS | 29606 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.25 (0.9%) stddev-sans-first:1.17 02:53:23 INFO - PROCESS | 29606 | Values: 145.0 146.0 147.0 146.0 147.0 147.0 147.0 149.0 148.0 145.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:53:23 INFO - PROCESS | 29606 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.50 stddev:2.25 (3.5%) stddev-sans-first:2.37 02:53:23 INFO - PROCESS | 29606 | Values: 64.0 62.0 63.0 64.0 65.0 65.0 67.0 64.0 70.0 64.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 02:53:23 INFO - PROCESS | 29606 | Values: 65.0 65.0 66.0 65.0 66.0 67.0 65.0 66.0 65.0 65.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:4.01 (4.7%) stddev-sans-first:3.33 02:53:23 INFO - PROCESS | 29606 | Values: 93.0 87.0 90.0 83.0 83.0 83.0 91.0 83.0 83.0 83.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:144.00 stddev:11.76 (8.2%) stddev-sans-first:12.31 02:53:23 INFO - PROCESS | 29606 | Values: 151.0 138.0 148.0 148.0 140.0 138.0 138.0 140.0 176.0 139.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:175.50 stddev:2.83 (1.6%) stddev-sans-first:2.60 02:53:23 INFO - PROCESS | 29606 | Values: 180.0 182.0 174.0 176.0 175.0 175.0 174.0 175.0 176.0 173.0 02:53:23 INFO - PROCESS | 29606 | 02:53:23 INFO - PROCESS | 29606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.65 (2.3%) stddev-sans-first:1.73 02:53:23 INFO - PROCESS | 29606 | Values: 71.0 72.0 73.0 74.0 70.0 70.0 74.0 70.0 70.0 72.0 02:53:23 INFO - PROCESS | 29606 | -------- Summary: end -------- 02:53:23 INFO - PROCESS | 29606 | 02:53:25 INFO - TEST-INFO | 29606: exit 0 02:53:25 INFO - TEST-OK | kraken | took 64882ms 02:53:25 INFO - SUITE-END | took 1186s 02:53:25 INFO - Completed test suite (00:19:46) 02:53:25 INFO - javascript benchmark 02:53:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.5466543354914, 2614.9477010459805, 2647.96028059579, 2663.7469440403165, 2675.5317819381603, 4525.027119169378, 4597.195490789107, 4696.856473870371, 4805.111054454928, 4840.225563909775, 4616.19216637088, 4626.074785042988, 4628.1669299526075, 4633.976830115845, 4637.930431043537, 4242.109157077018, 4249.851255206068, 4259.212045771526, 4317.978410107945, 4333.349997500384, 4382.364557139213, 4398.296272596369, 4402.7578483183415, 4405.845795397162, 4422.204003279408, 4329.047609525899, 4430.689851710382, 4432.800523976429, 4437.156940181371, 4490.865274041784, 4379.737215767048, 4447.043885564619, 4447.933281000787, 4472.0, 4472.329150627399, 4188.623023927861, 4233.280342341809, 4353.717008394476, 4393.692441529094, 4394.670399720002, 4588.931166032512, 4625.583697467244, 4643.837465688718, 4718.504557021498, 4729.645276604234, 4861.9027619447415, 4862.902741945141, 4873.926891096637, 4942.258661200813, 5009.874753131165, 4915.729634870081, 4936.4076310842565, 4947.65366424354, 4966.652334336598, 5028.84913452597, 4443.6889417741095, 4485.529019452975, 4588.403507543998, 4640.930386044212, 4726.976365118152, 5074.82238121664, 5085.1355269604255, 5087.4149472811105, 5092.694438333712, 5131.512506311894, 4836.46798852126, 4887.0, 4892.755362231946, 4901.411830580353, 4907.386576677915, 4779.641526885497, 4826.7827947742435, 4867.050925069578, 5000.524950129732, 5000.649954503223, 4956.925646115311, 4958.45456999737, 4959.504049595012, 4975.0796102721115, 5016.949830501721, 4943.382077240345, 4949.7772600233075, 4957.603391728653, 4959.7272150032095, 5016.874578135576, 4027.0536423940353, 4075.694322925792, 4076.8165432555606, 4112.712110152321, 4171.20747058058, 3658.378075727133, 3664.633536646314, 3699.2416554606243, 3723.106454450912, 3729.720270979633, 4368.847090351823, 4370.366296886934, 4376.627986621173, 4377.277749171415, 4426.247537918562, 4869.220924652039, 4927.531884470969, 5037.496250375007, 5046.77289521965, 5104.336436263262, 4344.543822898613, 4385.101054283864, 4439.822407103679, 4443.733375997451, 4481.7535035573355, 4551.6813823032735, 4570.063137056895, 4570.177368073779, 4571.2000399929875, 4634.698744581591, 4515.503294637521, 4829.661923665451, 4834.975825120852, 4845.055214233191, 4889.877753056202, 4780.880477988078, 4959.256111583291, 5030.270610761492, 5043.319151914591, 5119.641625086358, 4773.0, 4776.283557466408, 4780.139574876416, 4781.450133234723, 4823.421189457147, 4682.063587282489, 4970.229614409773, 4970.353853998957, 4978.178600530872, 5034.194528875362, 4787.4494433140635, 4844.854654360375, 4866.221404575251, 4871.585915197248, 4873.439554451284, 4678.157931572349, 4717.976410117927, 4723.362346083235, 4726.929096063493, 4728.030753695553, 4723.574878260973, 4733.881652958704, 4809.44691360484, 4872.1717308057005, 4894.779734911866, 4837.661363704507, 4842.7336496493035, 4847.587955023862, 4882.218844984785, 4909.533594308535, 4946.950530494649, 4951.777170027285, 4958.801647934042, 4959.305697202322, 4961.3798275215595, 4612.354270402214, 4663.160631086437, 4666.370040044686, 4719.961608446137, 4857.222844344888], "value": 4586.110217211888, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.7284471341973, 554.2517601238332, 563.8562166647504, 564.7119968815903, 569.1974316214137, 28156.57765133522, 38953.80523097384, 40284.0, 40288.59711402889, 44145.7792711036, 34621.653783462156, 34832.303353932904, 34883.47674784874, 34891.30217395651, 34905.0, 7601.923980760191, 7739.0, 7742.8838567421535, 7744.264294892005, 7748.3413909817455, 7600.619969001527, 7676.961615191916, 7683.961580192091, 7685.730999415022, 7688.231176882323, 7684.615769211545, 7726.961365193166, 7739.729109481169, 7740.729074482394, 7755.0, 7695.961520192392, 7731.613419329011, 7732.342750866183, 7741.535507869546, 7749.225077492262, 7589.279018493235, 7655.425843061737, 7656.157822639505, 7663.3486153677, 7669.616519174075, 38150.80924595387, 38381.232375352614, 38435.0, 38485.230295393936, 38507.0, 2855.1006432973754, 2902.2889392099073, 2910.0, 2929.414117176573, 3032.1286140334423, 27534.724652753415, 27591.586126208123, 27815.304617384525, 28603.28491787722, 28646.713532864615, 3309.470484722457, 3322.900312990614, 3328.567286252796, 3353.0946644406117, 3374.780639258465, 197792.0, 254495.0, 254547.0, 254698.0, 255060.0, 53228.201576976375, 53670.46329536733, 53670.73164634152, 53692.0, 53706.06437809018, 33078.66921330804, 33881.32237355288, 34085.48871766926, 47324.29013564799, 47559.76220118877, 14010.369533371022, 14134.787978180335, 14160.07959482651, 14206.0, 14217.146971181763, 10771.515281812337, 10799.352038877692, 10853.837192442119, 10864.293820901774, 10908.563657453613, 17500.912495437442, 17589.12054397275, 17734.46796596104, 17749.0, 17811.376601818873, 6523.804285871432, 6757.425618822455, 6803.353681400259, 6852.314768523208, 6870.519063665495, 735.2941176470648, 840.6805413942785, 853.6798700487317, 915.7619019055094, 979.2900147393225, 25911.611325829752, 27477.713163808756, 27667.58498622522, 28120.0, 28203.43593128126, 719.6293908636951, 831.4096991136361, 846.7967687754895, 909.8271328447706, 969.6896992962326, 11537.307761534335, 11908.33283340333, 13348.332583370986, 13489.032412869154, 13612.659683507793, 363705.0, 365156.0, 365828.0, 366621.0, 366716.0, 49165.75417122892, 49708.502914970384, 49787.75106124446, 49809.0, 49825.750871245415, 1048.9423081730426, 1089.9782004359868, 1151.073385924339, 1155.5146838327923, 1166.585862018971, 24988.37529061788, 28747.856260718563, 29023.854880725463, 29184.41631167407, 29187.270318242216, 40267.39598906077, 40866.38700419437, 40880.1823963525, 40893.182136357704, 40920.0, 283181.0, 284018.0, 284317.0, 284625.0, 284742.0, 22555.43611409662, 23370.0, 23372.181973630843, 24581.754182458662, 24998.250052498453, 40311.3953290695, 40315.798421007705, 40745.59254407418, 41037.38443923284, 41116.38325425181, 30305.848470757504, 30506.0, 30529.0, 30711.846440767655, 31149.844250778602, 34534.82732586321, 35263.64736352603, 35320.82339588286, 35427.468587971714, 35663.82168089143, 34828.30343393169, 35052.12369690778, 35128.29743405169, 35223.47164792479, 36266.0, 27222.0, 27721.722782771914, 27937.0, 28574.142775716762, 28774.568381473877, 24415.51168976646, 24763.752362476145, 24795.752042479344, 25201.74798251994, 25241.747582523938], "value": 16626.353796397856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.3132241549655, 350.21377008615644, 360.09077080372055, 360.5403111033432, 385.67795890431506, 12005.459754311056, 15402.152881591508, 15888.841111588896, 16306.429274975379, 17069.48791536253, 13715.451381944735, 14147.151170929752, 14217.360218790154, 14979.0, 16141.43504977326, 3776.565694945089, 4421.977890110553, 4532.9093418131615, 4583.724976501404, 4598.229681572602, 4909.484504127051, 4994.97502512487, 4996.1756310208775, 4999.550040496355, 4999.875003124915, 4645.535446455361, 4954.182559877634, 4963.900721985558, 4967.726775027372, 4970.502949705019, 4494.325851122341, 4534.41052663155, 4578.221702310615, 4614.653900957442, 4619.307103934403, 4443.178012067778, 4454.196050599512, 4496.213162696515, 4498.0, 4499.820007199708, 11291.774164516746, 16316.673666526722, 19765.703514447294, 20252.493687657778, 20372.0, 1845.0313585367655, 1851.3242666426656, 1885.0480507343705, 2080.063971212945, 2240.9215677451375, 8755.912440875574, 9164.0, 9495.430274183502, 9585.233181345546, 9839.163671087967, 1694.0682624556446, 1753.281154726556, 1756.4379398592455, 1766.3994241957796, 1768.6639538487775, 65280.3471965279, 68025.0, 69343.3065669347, 71109.28890711078, 72191.63904180499, 9611.855822162674, 9679.274054445945, 9700.563474643657, 9847.80304393908, 9962.402255864672, 13204.669883252996, 13279.800802987962, 13282.601521954357, 13288.800667989988, 13292.069555131047, 5646.604737668324, 5820.301563812285, 5835.679037652885, 6286.717097730613, 7500.924990750132, 6445.16212892321, 6622.0, 6675.098861653614, 6730.663466826639, 6873.450123990069, 3798.772073675588, 4101.384792281182, 4166.104287578125, 4249.46881639795, 7254.724052230811, 2843.8151520151123, 2905.418916216765, 3027.606411166534, 3222.2610780836103, 3286.5891763529557, 771.6566128073066, 856.6402111113347, 882.6892065283049, 907.9546022698971, 961.2214106573698, 16029.679406411806, 16135.83864161367, 16533.58666033359, 17032.659346812994, 17894.91052544729, 825.5830805443213, 835.6406745099665, 835.7409203147043, 852.7015544559355, 853.5646820121783, 8467.153284671607, 9798.412095274163, 9809.11717945374, 9816.607335706492, 9818.459984700767, 341659.0, 347816.0, 351027.0, 351080.0, 364506.0, 79645.0, 80699.59650201711, 80893.59553202314, 82664.0, 85707.0, 871.8866547348931, 895.4850960697624, 898.3621628643737, 898.7034278688018, 907.1971305394641, 15118.773218401513, 15243.618909527351, 15296.541103766906, 15399.923000384926, 16057.759133612772, 36058.27883442264, 36242.63757362393, 36484.0, 37185.07037324089, 38508.0, 49875.75062124666, 51072.489275106775, 51449.742751286, 51492.74253628708, 52261.648225829165, 6861.627674465227, 7230.42156627479, 7269.672864720995, 7324.267573242633, 7527.0, 9574.55268389662, 11271.605493807678, 12094.818577721517, 12171.634850954486, 12335.814962775386, 10204.744881377728, 10211.897881021392, 10256.641017564349, 10344.172466202535, 10815.72960675958, 10348.844767328346, 10613.363198208132, 10637.840432393676, 10829.29609575375, 10872.565097396331, 9924.0, 10409.84385234207, 10662.46687665598, 10836.620718274822, 10862.511186996762, 6987.406070484066, 7060.505764596429, 7103.2186459488385, 7181.605011724405, 7191.676374563052, 9642.42145471274, 10441.634542790965, 10580.576776928836, 10753.784924301313, 10763.892361076289], "value": 8012.722917861599, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.347687456027, 1346.1855577375688, 1395.8185435893338, 1562.6777175014959, 1613.9670610809085, 6725.9327406725915, 6954.269801670827, 7346.55920644761, 7948.761537153895, 7950.562719050457, 7300.744473943413, 7614.200508946564, 7615.162332143474, 7784.532928024322, 7804.843903121949, 2124.798144176301, 2128.095559387262, 2137.5831712816007, 2154.2244791874914, 2162.5350549631826, 1765.735139729038, 1822.2073398071882, 2090.2579584247524, 2118.756343020549, 2155.3426205007468, 1730.8701847361435, 1745.738139279112, 1748.763916871225, 2088.7702352741185, 2106.1470104607583, 2071.1818831561523, 2073.699313599535, 2081.40679906226, 2087.5929193807137, 2088.185607613017, 2029.2694629933212, 2039.2250944640941, 2068.5759419319, 2079.781622929586, 2081.323569839808, 7626.0, 7716.074071111447, 7716.382689384835, 7779.72770953014, 7819.726309579194, 4282.42187304713, 4404.185225733249, 4405.603495685404, 4407.140607581523, 4415.4259946206785, 2561.039610146195, 2712.918221445561, 2804.929876753077, 2820.830750154997, 2829.6462942132234, 846.1496196322718, 874.4010352908278, 875.9969834539417, 877.4296707140346, 889.515214208258, 10168.44073575953, 10255.0, 10263.127634151106, 10266.640667576674, 10269.589216431334, 3793.7534060285993, 3870.5161854768153, 3987.8404863805704, 4009.7594144351433, 4090.795460226977, 8808.955955220312, 8810.251128654008, 8821.294296456268, 8825.602847871733, 8826.117388261122, 4437.090396468716, 4438.245498265238, 4440.444944381952, 4442.644588432918, 4445.644348452116, 4004.3793212051596, 4038.7172897897453, 4060.5939406059747, 4066.694997875112, 4067.1052368478886, 3418.7948723076697, 3440.139965008748, 3472.3749725049734, 3506.9298614027575, 3588.300281445145, 1083.409541799721, 1090.5583238788304, 1093.3221402730358, 1107.9169062320198, 1111.8332250162541, 691.2120182991393, 802.594689681707, 806.2099142839933, 818.7789296889806, 826.9297109745619, 4853.635977301717, 4882.0, 4979.6265280104135, 4990.525900039491, 5170.8965820684125, 377.16458045429505, 390.4026838936432, 395.4819186865158, 399.31916083078283, 400.14968192590743, 3337.7997320160866, 3431.9656803431644, 3434.914127146841, 3468.098294443412, 3503.2292895562937, 8577.571121444027, 8814.911850881537, 8908.420952638058, 8923.73228803137, 8934.821303573892, 8876.112388761072, 8893.28853691703, 8896.59965301563, 8913.55432228386, 8918.37571369998, 6573.967130164318, 6664.1336626239245, 6670.599764014175, 6673.332666733288, 6676.365745254193, 4873.098476781806, 4947.183714687037, 5021.72380519075, 5130.368745253607, 5190.403103642979, 8328.08391076969, 8379.120192379713, 8396.160383961555, 8408.537530435884, 8502.022267439324, 8443.113473085237, 8475.449095808754, 8513.233808957224, 8575.571221438779, 8626.137386261324, 6428.4214420702365, 6538.705758240795, 6551.574147680385, 6588.4399826013405, 6595.076689263411, 7114.466415018997, 7254.637268136466, 7308.232635573401, 7318.743843965649, 7324.08448943882, 5116.232565115262, 6455.9677201613695, 6524.5432819704065, 6540.640264785482, 6674.43267322283, 6554.934450655433, 6591.96704016496, 6637.236717777518, 6649.767258145942, 6678.565893216925, 5961.165436838759, 6078.787242446493, 6082.148499210202, 6088.117223002729, 6092.208012958287, 4472.485664148535, 4477.597016268552, 4490.416245888014, 4555.612772914339, 4694.64790140734, 4315.158544083999, 4395.450568678915, 4405.5153933066695, 4537.455505339381, 4564.817407303671], "value": 3862.9344074241567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.7986669731096, 278.9414223013167, 287.3319532087895, 287.8643750404653, 293.36632872994335, 4792.928106078407, 4809.38885473366, 4825.445073816508, 4834.371531700883, 4841.903161936759, 4734.479207287196, 4752.47722750498, 4776.641751868607, 4785.832495862645, 4792.233242681172, 3565.94651080234, 3617.656322649357, 3674.926501469969, 3706.7219958503083, 3755.1738617504243, 3736.9252614947686, 3742.7754334739866, 3744.6629803317696, 3757.943630845526, 3760.586335503106, 3703.8518459261595, 3708.962910370902, 3716.145286584074, 3716.293904158215, 3722.646348596879, 3512.947305790415, 3613.8012409317475, 3622.87319943802, 3692.8153592320277, 3721.4603882436895, 3280.8359582020803, 3283.40898638245, 3287.1453422110185, 3293.752968527346, 3293.8682452701864, 4620.768961551909, 4626.542639068683, 4626.629869610457, 4628.310666606664, 4631.606313463326, 3941.467901833273, 4193.559676233982, 4234.597713217239, 4234.767087810169, 4244.236037513247, 4965.48552691429, 4968.378952630921, 4968.726720030397, 4974.825881094144, 4988.102141614508, 3500.9824950875336, 3501.124718820295, 3502.2470168913806, 3508.1931155834045, 3510.9642655416715, 5004.799808007639, 5172.715500647463, 5211.462618527506, 5225.555827754645, 5228.686278823283, 3538.363094642989, 3540.8760693375607, 3553.6673747344744, 3569.3396721606587, 3578.4453409721536, 3606.1151079136584, 3608.963910360915, 3610.6389361063684, 3620.2759448110482, 3629.911026691982, 4191.790410479463, 4194.6853985951175, 4197.9370309445385, 4211.831526738957, 4221.810018549173, 4921.8523444296725, 4978.27814966835, 5000.524845170683, 5091.236314552847, 5093.923591146136, 1245.6449911775283, 1256.145820841818, 1256.7989121740661, 1257.289631358298, 1266.468083404972, 762.4357975098387, 776.5961699916124, 786.1666633368648, 794.4875555266821, 798.7883210949103, 4289.528151903288, 4338.349247612883, 4469.642428605704, 4473.373727678128, 4482.574155455227, 5160.509751573594, 5165.431802501722, 5166.844994650167, 5184.0, 5191.402988656353, 4450.0, 4483.125790470892, 4483.820647174141, 4491.371208030879, 4499.572540608637, 2599.9480010399684, 2743.477370059596, 2750.573661082535, 2765.5298599238176, 2765.9723402766117, 4880.633952453509, 4887.828925987645, 4896.674079812061, 4912.582430493377, 4914.164592019365, 5049.747512624354, 5234.633575649744, 5283.920741188886, 5287.550558202596, 5302.416734159239, 4928.926066109011, 4950.4059512858685, 4962.255661650709, 4971.776270067856, 4975.676581022222, 5237.947620523746, 5254.500822421864, 5265.2365407015, 5318.755559109018, 5319.574434045345, 4858.684185527929, 5078.873028174326, 5159.355080614773, 5168.276441298296, 5192.792288308577, 4918.827841025547, 4928.950710492849, 4943.431505376784, 4952.529509696573, 4960.652754307308, 3516.2088530080528, 3546.1737205338754, 3552.87564935226, 3578.8031658259047, 3595.4786555948717, 5082.771275292546, 5198.142306519382, 5240.34495688039, 5263.36839579253, 5290.81482148123, 5049.444561098203, 5061.114304996538, 5065.746712664426, 5071.855449621258, 5100.336956195671, 5060.873478163076, 5067.87330316745, 5075.923861142012, 5145.195868251886, 5148.794048238028, 4759.666823322473, 4990.775415106402, 5011.273365362075, 5022.397312322545, 5049.166887463527, 4847.316039809841, 4950.331705219894, 4979.182598351503, 5120.641555091108, 5124.205748109049, 4906.313116163668, 4914.238293064581, 4936.456989731055, 4941.703497790144, 4944.134776414185], "value": 3760.8076393254178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7230720188079, 641.4771960851903, 654.4862283107761, 662.8475450646348, 716.0834132310641, 12609.5586654467, 13312.93343533281, 13707.246101464416, 13888.0, 13894.51369202078, 13343.199408035525, 13673.24797136157, 13695.931520342385, 13702.725945481085, 13709.177449353047, 634.1755717567167, 760.425878461762, 783.3967844759532, 787.2285160542672, 787.8818177273398, 640.5900223856736, 767.267259766924, 779.6842278877064, 790.0795573157264, 792.8136887831355, 828.3787159630277, 828.70580943765, 828.846663367279, 832.9541875196862, 835.5822088955522, 650.6193876582205, 819.8237378963491, 820.7332616899472, 820.9507429554246, 821.6959724901794, 490.0639778023957, 582.8571999860061, 590.6751286792247, 592.973316200772, 595.8916415467228, 12874.227546347156, 12888.677783055406, 12906.290154041524, 12936.611901642966, 13014.934925325313, 10926.672199834018, 11585.073194144448, 11668.88331116695, 11675.708107297301, 12054.337011464366, 10942.617008404668, 10988.450577471094, 11055.778884422347, 11145.331280123137, 11615.070794336518, 3939.995301198176, 3940.940885886714, 3964.8697577688995, 3967.504061992251, 4006.4591280177387, 62409.0, 62669.68665156691, 62873.371266287206, 62914.37085629177, 62968.37031629671, 9270.034712683891, 9320.627174913063, 9357.859632105525, 9405.584162152214, 9430.597026048172, 17074.743878841826, 17159.227834747468, 17331.826681733273, 17404.912975435043, 17440.12799360027, 6296.905546416808, 6381.585196962183, 6392.680365981775, 6547.312532184052, 6714.496412769062, 3410.437277849127, 3457.135716070982, 3515.7890526567976, 3543.078799512094, 3581.8925432237074, 2687.6237326774267, 2762.2956146182596, 2773.5007698614445, 2773.9029133980616, 2775.9028434005118, 463.2009783124084, 471.1754429747941, 471.32365056144545, 477.06019142289637, 477.28645674716523, 520.3989392251955, 561.5942927731936, 567.51761003147, 567.9943200568024, 580.2543731305337, 7890.487118337404, 7954.403419743542, 7963.4027447941635, 7994.2405471480115, 8099.311558517592, 402.3140545370137, 431.91577642359437, 502.9739331763235, 582.8805094955524, 598.4583951523878, 3674.3386190485435, 3706.4440333949583, 3884.766913985113, 3959.1685745993086, 3986.123052928351, 84953.0, 102860.37128329244, 106200.0, 108478.0, 108758.0, 88595.0, 88779.0, 89096.0, 90882.54558727297, 91081.0, 73308.63345683238, 78493.82259266115, 79366.6031669838, 80945.0, 81096.0, 7202.099737532809, 7213.422926165999, 7254.927450725636, 7379.778606641809, 7533.3973282138395, 44791.32813007873, 44953.55046449494, 45193.32210016918, 45305.0, 47240.7637961808, 61931.0, 64887.35112648813, 65986.34013659802, 66683.66658166678, 69126.65436672785, 9210.585523651585, 9255.120763527455, 9384.483853388128, 9657.951710241405, 9710.320277580502, 10136.543855526372, 10179.134773544036, 10481.580736770444, 10549.156067514426, 10561.471926403496, 9479.336446448959, 9678.734831907754, 9979.251556133175, 9986.550605222637, 10036.849447258443, 9813.460259685786, 9828.361156524803, 10187.643432479828, 10450.581976720847, 10498.422586757497, 9565.473898935625, 9708.660196893357, 10062.345947513388, 10066.094051535398, 10076.798464030531, 7729.497582657109, 7857.685692572233, 7920.960395198218, 8008.479448835807, 8345.290650294794, 8013.2387423194705, 8248.628811703367, 8367.790805229917, 8409.579521023801, 8542.572871356531], "value": 6248.288233851218, "unit": "score"}], "name": "dromaeo_css", "value": 6175.4972650848695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 115.0, 113.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 127.0, 171.0, 138.0, 128.0, 128.0, 129.0, 178.0, 132.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 114.0, 77.0, 77.0, 77.0, 77.0, 97.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 117.0, 84.0, 83.0, 83.0, 103.0, 82.0, 83.0, 110.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 149.0, 148.0, 145.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 64.0, 65.0, 65.0, 67.0, 64.0, 70.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 87.0, 90.0, 83.0, 83.0, 83.0, 91.0, 83.0, 83.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 148.0, 148.0, 140.0, 138.0, 138.0, 140.0, 176.0, 139.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 182.0, 174.0, 176.0, 175.0, 175.0, 174.0, 175.0, 176.0, 173.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 73.0, 74.0, 70.0, 70.0, 74.0, 70.0, 70.0, 72.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1557.2999999999997, "alertThreshold": 2.0}]} 02:53:25 INFO - Return code: 0 02:53:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:53:25 INFO - # TBPL SUCCESS # 02:53:25 INFO - Running post-action listener: _resource_record_post_action 02:53:25 INFO - [mozharness: 2016-10-04 09:53:25.740611Z] Finished run-tests step (success) 02:53:25 INFO - Running post-run listener: _resource_record_post_run 02:53:25 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 408150016; Read time: 0; Write time: 368396 02:53:25 INFO - TinderboxPrint: CPU usage
13.0% 02:53:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:53:25 INFO - TinderboxPrint: I/O write bytes / time
408,150,016 / 368,396 02:53:25 INFO - TinderboxPrint: CPU idle
8,347.9 (87.0%) 02:53:25 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 02:53:25 INFO - TinderboxPrint: Swap in / out
0 / 0 02:53:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99987456; Read time: 0; Write time: 104968 02:53:25 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291385344; Read time: 0; Write time: 257988 02:53:26 INFO - Running post-run listener: _upload_blobber_files 02:53:26 INFO - Blob upload gear active. 02:53:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:26 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 02:53:26 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:53:26 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:53:26 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:27 INFO - (blobuploader) - INFO - Done attempting. 02:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:31 INFO - (blobuploader) - INFO - Done attempting. 02:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:32 INFO - (blobuploader) - INFO - Done attempting. 02:53:32 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:32 INFO - Return code: 0 02:53:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a26ec379153407a1f3b65a89db2ca9ec69f9624d2e212e09393e0332abd11fd7f54c3f0fa32c1a2c348d26b6b6f74a24d4b1ea76ae0f4050a8b1db8577b84aa0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/395819d3b178bc03b1f08eefc2c3a29a7a18c28ff7c8580c15fc92bbdd4c0253d0a59df9746acbcdc1302188bbd02232959548b03207f22e4e9867541b3ef619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/33d66abded4023106956b6de7264fddc6d381bc4dde64fdb523d5e8a92cd48c115accadf24744c6e9b38fb1889e543d6e5cbebf860a2ddea12f0cc5c044087f6"} 02:53:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:32 INFO - Contents: 02:53:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a26ec379153407a1f3b65a89db2ca9ec69f9624d2e212e09393e0332abd11fd7f54c3f0fa32c1a2c348d26b6b6f74a24d4b1ea76ae0f4050a8b1db8577b84aa0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/395819d3b178bc03b1f08eefc2c3a29a7a18c28ff7c8580c15fc92bbdd4c0253d0a59df9746acbcdc1302188bbd02232959548b03207f22e4e9867541b3ef619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/33d66abded4023106956b6de7264fddc6d381bc4dde64fdb523d5e8a92cd48c115accadf24744c6e9b38fb1889e543d6e5cbebf860a2ddea12f0cc5c044087f6"} 02:53:32 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:32 INFO - Copying logs to upload dir... 02:53:32 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.711406 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 02:53:31.197471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 02:53:31.201152) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a26ec379153407a1f3b65a89db2ca9ec69f9624d2e212e09393e0332abd11fd7f54c3f0fa32c1a2c348d26b6b6f74a24d4b1ea76ae0f4050a8b1db8577b84aa0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/395819d3b178bc03b1f08eefc2c3a29a7a18c28ff7c8580c15fc92bbdd4c0253d0a59df9746acbcdc1302188bbd02232959548b03207f22e4e9867541b3ef619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/33d66abded4023106956b6de7264fddc6d381bc4dde64fdb523d5e8a92cd48c115accadf24744c6e9b38fb1889e543d6e5cbebf860a2ddea12f0cc5c044087f6"} build_url:https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011507 build_url: 'https://queue.taskcluster.net/v1/task/LyoE_xjKQLa36YldRP_t7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a26ec379153407a1f3b65a89db2ca9ec69f9624d2e212e09393e0332abd11fd7f54c3f0fa32c1a2c348d26b6b6f74a24d4b1ea76ae0f4050a8b1db8577b84aa0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/395819d3b178bc03b1f08eefc2c3a29a7a18c28ff7c8580c15fc92bbdd4c0253d0a59df9746acbcdc1302188bbd02232959548b03207f22e4e9867541b3ef619", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/33d66abded4023106956b6de7264fddc6d381bc4dde64fdb523d5e8a92cd48c115accadf24744c6e9b38fb1889e543d6e5cbebf860a2ddea12f0cc5c044087f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 02:53:31.231773) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:53:31.232518) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475573041.610878-2042990152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 02:53:31.317199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 02:53:31.317993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 02:53:31.318604) ========= ========= Total master_lag: 0.19 =========